builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0200 starttime: 1458045070.8 results: success (0) buildid: 20160315030230 builduid: 30eedc3df6ee419ea5f1d388e35c6e2b revision: 5e14887312d4523ab59c3f6c6c94a679cf42b496 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:10.806604) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:10.809053) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:10.809344) ========= bash -c pwd in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'pwd'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UAQwe0HAqq/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005502 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:10.838126) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:10.838398) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:10.860835) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:10.861095) ========= rm -rf properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UAQwe0HAqq/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005437 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:10.909189) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:10.909451) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:10.909772) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:10.913074) ========= bash -c 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'wget -Oarchiver_client.py --no-check-certificate --tries=10 --waitretry=3 https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UAQwe0HAqq/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-15 05:31:10-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 9.58M=0.001s 2016-03-15 05:31:11 (9.58 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.153264 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:11.082597) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:11.085892) ========= rm -rf scripts in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UAQwe0HAqq/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.025443 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:11.133461) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-15 05:31:11.133793) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 5e14887312d4523ab59c3f6c6c94a679cf42b496 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 5e14887312d4523ab59c3f6c6c94a679cf42b496 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UAQwe0HAqq/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-15 05:31:11,210 truncating revision to first 12 chars 2016-03-15 05:31:11,210 Setting DEBUG logging. 2016-03-15 05:31:11,210 attempt 1/10 2016-03-15 05:31:11,210 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/5e14887312d4?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 05:31:13,068 unpacking tar archive at: mozilla-central-5e14887312d4/testing/mozharness/ program finished with exit code 0 elapsedTime=2.296465 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-15 05:31:13.449686) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:13.453092) ========= echo 5e14887312d4523ab59c3f6c6c94a679cf42b496 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'5e14887312d4523ab59c3f6c6c94a679cf42b496'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UAQwe0HAqq/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 5e14887312d4523ab59c3f6c6c94a679cf42b496 program finished with exit code 0 elapsedTime=0.005555 script_repo_revision: '5e14887312d4523ab59c3f6c6c94a679cf42b496' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:13.505187) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:13.505484) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-15 05:31:13.522069) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-15 05:31:13.522339) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UAQwe0HAqq/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PROPERTIES_FILE=/builds/slave/test/buildprops.json PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:31:13 INFO - MultiFileLogger online at 20160315 05:31:13 in /builds/slave/test 05:31:13 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:31:13 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:31:13 INFO - {'append_to_log': False, 05:31:13 INFO - 'base_work_dir': '/builds/slave/test', 05:31:13 INFO - 'blob_upload_branch': 'Firefox', 05:31:13 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:31:13 INFO - 'branch': 'Firefox', 05:31:13 INFO - 'buildbot_json_path': 'buildprops.json', 05:31:13 INFO - 'config_files': ('talos/mac_config.py',), 05:31:13 INFO - 'default_actions': ('clobber', 05:31:13 INFO - 'read-buildbot-config', 05:31:13 INFO - 'download-and-extract', 05:31:13 INFO - 'populate-webroot', 05:31:13 INFO - 'create-virtualenv', 05:31:13 INFO - 'install', 05:31:13 INFO - 'run-tests'), 05:31:13 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:31:13 INFO - 'download_minidump_stackwalk': True, 05:31:13 INFO - 'download_symbols': 'ondemand', 05:31:13 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:31:13 INFO - 'tooltool.py': '/tools/tooltool.py', 05:31:13 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:31:13 INFO - '/tools/misc-python/virtualenv.py')}, 05:31:13 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:31:13 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:31:13 INFO - 'installer_path': 'installer.exe', 05:31:13 INFO - 'log_level': 'info', 05:31:13 INFO - 'log_name': 'talos', 05:31:13 INFO - 'log_to_console': True, 05:31:13 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:31:13 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:31:13 INFO - 'opt_config_files': (), 05:31:13 INFO - 'pip_index': False, 05:31:13 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:13 INFO - 'cmd': ('bash', 05:31:13 INFO - '-c', 05:31:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:13 INFO - 'enabled': True, 05:31:13 INFO - 'halt_on_failure': False, 05:31:13 INFO - 'name': 'check_screen_resolution'},), 05:31:13 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:13 INFO - 'cmd': ('bash', 05:31:13 INFO - '-c', 05:31:13 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:13 INFO - 'enabled': True, 05:31:13 INFO - 'halt_on_failure': False, 05:31:13 INFO - 'name': 'check_screen_resolution'},), 05:31:13 INFO - 'run_cmd_checks_enabled': True, 05:31:13 INFO - 'sps_profile': False, 05:31:13 INFO - 'sps_profile_interval': 0, 05:31:13 INFO - 'suite': 'dromaeojs', 05:31:13 INFO - 'system_bits': '32', 05:31:13 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:31:13 INFO - 'title': 't-yosemite-r7-0200', 05:31:13 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:31:13 INFO - 'use_talos_json': True, 05:31:13 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:31:13 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:31:13 INFO - 'work_dir': 'build'} 05:31:13 INFO - ##### 05:31:13 INFO - ##### Running clobber step. 05:31:13 INFO - ##### 05:31:13 INFO - Running pre-action listener: _resource_record_pre_action 05:31:13 INFO - Running main action method: clobber 05:31:13 INFO - rmtree: /builds/slave/test/build 05:31:13 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:31:15 INFO - Running post-action listener: _resource_record_post_action 05:31:15 INFO - ##### 05:31:15 INFO - ##### Running read-buildbot-config step. 05:31:15 INFO - ##### 05:31:15 INFO - Running pre-action listener: _resource_record_pre_action 05:31:15 INFO - Running main action method: read_buildbot_config 05:31:15 INFO - Using buildbot properties: 05:31:15 INFO - { 05:31:15 INFO - "project": "", 05:31:15 INFO - "product": "firefox", 05:31:15 INFO - "script_repo_revision": "production", 05:31:15 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:31:15 INFO - "repository": "", 05:31:15 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:31:15 INFO - "buildid": "20160315030230", 05:31:15 INFO - "stage_platform": "macosx64", 05:31:15 INFO - "basedir": "/builds/slave/test", 05:31:15 INFO - "nightly_build": "True", 05:31:15 INFO - "buildnumber": 182, 05:31:15 INFO - "slavename": "t-yosemite-r7-0200", 05:31:15 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 05:31:15 INFO - "platform": "yosemite_r7", 05:31:15 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:31:15 INFO - "branch": "mozilla-central", 05:31:15 INFO - "repo_path": "mozilla-central", 05:31:15 INFO - "revision": "5e14887312d4523ab59c3f6c6c94a679cf42b496", 05:31:15 INFO - "pgo_build": "False", 05:31:15 INFO - "builduid": "30eedc3df6ee419ea5f1d388e35c6e2b", 05:31:15 INFO - "slavebuilddir": "test" 05:31:15 INFO - } 05:31:15 INFO - Found installer url https://queue.taskcluster.net/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 05:31:15 INFO - Running post-action listener: _resource_record_post_action 05:31:15 INFO - ##### 05:31:15 INFO - ##### Running download-and-extract step. 05:31:15 INFO - ##### 05:31:15 INFO - Running pre-action listener: _resource_record_pre_action 05:31:15 INFO - Running main action method: download_and_extract 05:31:15 INFO - mkdir: /builds/slave/test/build/tests 05:31:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:15 INFO - https://queue.taskcluster.net/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 05:31:15 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:31:15 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 05:31:15 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:31:15 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json'}, attempt #1 05:31:16 INFO - Downloaded 1199 bytes. 05:31:16 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 05:31:16 INFO - Using the following test package requirements: 05:31:16 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:31:16 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:31:16 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 05:31:16 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:31:16 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 05:31:16 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:31:16 INFO - u'jsshell-mac.zip'], 05:31:16 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:31:16 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 05:31:16 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 05:31:16 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:31:16 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 05:31:16 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:31:16 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 05:31:16 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:31:16 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 05:31:16 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 05:31:16 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 05:31:16 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:31:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:16 INFO - https://queue.taskcluster.net/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:31:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:31:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:31:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:31:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:31:17 INFO - Downloaded 17853516 bytes. 05:31:17 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:31:17 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:31:20 INFO - Return code: 0 05:31:20 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip', u'firefox-48.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:31:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:20 INFO - https://queue.taskcluster.net/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:31:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:31:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:31:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip 05:31:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:31:24 INFO - Downloaded 17853516 bytes. 05:31:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:31:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 05:31:27 INFO - Return code: 0 05:31:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:27 INFO - https://queue.taskcluster.net/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:31:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:31:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:31:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip 05:31:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:31:28 INFO - Downloaded 10845263 bytes. 05:31:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 05:31:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 05:31:29 INFO - Return code: 0 05:31:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:29 INFO - https://queue.taskcluster.net/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:31:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:31:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:31:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 05:31:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg'}, attempt #1 05:31:32 INFO - Downloaded 111311571 bytes. 05:31:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:31:32 INFO - mkdir: /builds/slave/test/properties 05:31:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:31:32 INFO - Writing to file /builds/slave/test/properties/build_url 05:31:32 INFO - Contents: 05:31:32 INFO - build_url:https://queue.taskcluster.net/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 05:31:32 INFO - Running post-action listener: _resource_record_post_action 05:31:32 INFO - Running post-action listener: set_extra_try_arguments 05:31:32 INFO - ##### 05:31:32 INFO - ##### Running populate-webroot step. 05:31:32 INFO - ##### 05:31:32 INFO - Running pre-action listener: _resource_record_pre_action 05:31:32 INFO - Running main action method: populate_webroot 05:31:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:31:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:31:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:31:32 INFO - '--tppagecycles', 05:31:32 INFO - '7'], 05:31:32 INFO - 'tests': ['tsvgm']}}, 05:31:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:31:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:31:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:31:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 05:31:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:31:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:31:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:32 INFO - 'talos_options': ['--e10s'], 05:31:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:31:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:32 INFO - 'tests': ['damp', 'tps']}, 05:31:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:32 INFO - 'talos_options': ['--e10s'], 05:31:32 INFO - 'tests': ['damp', 'tps']}, 05:31:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:31:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:31:32 INFO - 'other': {'tests': ['a11yr', 05:31:32 INFO - 'ts_paint', 05:31:32 INFO - 'tpaint', 05:31:32 INFO - 'sessionrestore', 05:31:32 INFO - 'sessionrestore_no_auto_restore', 05:31:32 INFO - 'tabpaint']}, 05:31:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:31:32 INFO - 'tests': ['a11yr', 05:31:32 INFO - 'ts_paint', 05:31:32 INFO - 'tpaint', 05:31:32 INFO - 'sessionrestore', 05:31:32 INFO - 'sessionrestore_no_auto_restore', 05:31:32 INFO - 'tabpaint']}, 05:31:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:31:32 INFO - 'tests': ['a11yr', 05:31:32 INFO - 'ts_paint', 05:31:32 INFO - 'tpaint', 05:31:32 INFO - 'sessionrestore', 05:31:32 INFO - 'sessionrestore_no_auto_restore', 05:31:32 INFO - 'tabpaint']}, 05:31:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:31:32 INFO - 'tests': ['a11yr', 05:31:32 INFO - 'ts_paint', 05:31:32 INFO - 'tpaint', 05:31:32 INFO - 'sessionrestore', 05:31:32 INFO - 'sessionrestore_no_auto_restore', 05:31:32 INFO - 'tabpaint']}, 05:31:32 INFO - 'other_l64': {'tests': ['a11yr', 05:31:32 INFO - 'ts_paint', 05:31:32 INFO - 'tpaint', 05:31:32 INFO - 'sessionrestore', 05:31:32 INFO - 'sessionrestore_no_auto_restore', 05:31:32 INFO - 'tabpaint']}, 05:31:32 INFO - 'other_nol64': {'tests': ['a11yr', 05:31:32 INFO - 'ts_paint', 05:31:32 INFO - 'tpaint', 05:31:32 INFO - 'sessionrestore', 05:31:32 INFO - 'sessionrestore_no_auto_restore', 05:31:32 INFO - 'tabpaint']}, 05:31:32 INFO - 'svgr': {'tests': ['tsvgx', 05:31:32 INFO - 'tsvgr_opacity', 05:31:32 INFO - 'tart', 05:31:32 INFO - 'tscrollx', 05:31:32 INFO - 'cart']}, 05:31:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:31:32 INFO - 'tests': ['tsvgx', 05:31:32 INFO - 'tsvgr_opacity', 05:31:32 INFO - 'tart', 05:31:32 INFO - 'tscrollx', 05:31:32 INFO - 'cart']}, 05:31:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:32 INFO - 'tests': ['tp5o']}, 05:31:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:32 INFO - 'talos_options': ['--e10s'], 05:31:32 INFO - 'tests': ['tp5o']}, 05:31:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:32 INFO - 'talos_options': ['--xperf_path', 05:31:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:32 INFO - 'tests': ['tp5n']}, 05:31:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:31:32 INFO - 'talos_options': ['--e10s', 05:31:32 INFO - '--xperf_path', 05:31:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:31:32 INFO - 'tests': ['tp5n']}}, 05:31:32 INFO - 'talos.zip': {'path': '', 05:31:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:31:32 INFO - Running post-action listener: _resource_record_post_action 05:31:32 INFO - ##### 05:31:32 INFO - ##### Running create-virtualenv step. 05:31:32 INFO - ##### 05:31:32 INFO - Running pre-action listener: _resource_record_pre_action 05:31:32 INFO - Running main action method: create_virtualenv 05:31:32 INFO - Creating virtualenv /builds/slave/test/build/venv 05:31:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:31:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:31:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:31:32 INFO - Using real prefix '/tools/python27' 05:31:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:31:33 INFO - Installing distribute.............................................................................................................................................................................................done. 05:31:36 INFO - Installing pip.................done. 05:31:36 INFO - Return code: 0 05:31:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106875a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc194626e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106719d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106710b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:31:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:31:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 05:31:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:36 INFO - 'HOME': '/Users/cltbld', 05:31:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:36 INFO - 'LOGNAME': 'cltbld', 05:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:36 INFO - 'MOZ_NO_REMOTE': '1', 05:31:36 INFO - 'NO_EM_RESTART': '1', 05:31:36 INFO - 'PAGER': '/bin/cat', 05:31:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:36 INFO - 'PWD': '/builds/slave/test', 05:31:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:36 INFO - 'SHELL': '/bin/bash', 05:31:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 05:31:36 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 05:31:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:36 INFO - 'USER': 'cltbld', 05:31:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:36 INFO - 'XPC_FLAGS': '0x0', 05:31:36 INFO - 'XPC_SERVICE_NAME': '0', 05:31:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:31:36 INFO - Cleaning up... 05:31:36 INFO - Return code: 0 05:31:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106875a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc194626e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106719d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106710b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:31:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:31:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:31:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 05:31:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:36 INFO - 'HOME': '/Users/cltbld', 05:31:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:36 INFO - 'LOGNAME': 'cltbld', 05:31:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:36 INFO - 'MOZ_NO_REMOTE': '1', 05:31:36 INFO - 'NO_EM_RESTART': '1', 05:31:36 INFO - 'PAGER': '/bin/cat', 05:31:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:36 INFO - 'PWD': '/builds/slave/test', 05:31:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:36 INFO - 'SHELL': '/bin/bash', 05:31:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 05:31:36 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 05:31:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:36 INFO - 'USER': 'cltbld', 05:31:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:36 INFO - 'XPC_FLAGS': '0x0', 05:31:36 INFO - 'XPC_SERVICE_NAME': '0', 05:31:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:37 INFO - Downloading/unpacking psutil>=0.7.1 05:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:31:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:40 INFO - Installing collected packages: psutil 05:31:40 INFO - Running setup.py install for psutil 05:31:41 INFO - building 'psutil._psutil_osx' extension 05:31:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:31:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:31:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:31:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:31:41 INFO - building 'psutil._psutil_posix' extension 05:31:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:31:41 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:31:41 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:31:41 INFO - ^ 05:31:41 INFO - 1 warning generated. 05:31:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:31:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:31:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:31:42 INFO - Successfully installed psutil 05:31:42 INFO - Cleaning up... 05:31:42 INFO - Return code: 0 05:31:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106875a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc194626e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106719d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106710b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:31:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:31:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:31:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 05:31:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:42 INFO - 'HOME': '/Users/cltbld', 05:31:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:42 INFO - 'LOGNAME': 'cltbld', 05:31:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:42 INFO - 'MOZ_NO_REMOTE': '1', 05:31:42 INFO - 'NO_EM_RESTART': '1', 05:31:42 INFO - 'PAGER': '/bin/cat', 05:31:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:42 INFO - 'PWD': '/builds/slave/test', 05:31:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:42 INFO - 'SHELL': '/bin/bash', 05:31:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 05:31:42 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 05:31:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:42 INFO - 'USER': 'cltbld', 05:31:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:42 INFO - 'XPC_FLAGS': '0x0', 05:31:42 INFO - 'XPC_SERVICE_NAME': '0', 05:31:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:44 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:31:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:31:44 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:31:44 INFO - Installing collected packages: mozsystemmonitor 05:31:44 INFO - Running setup.py install for mozsystemmonitor 05:31:44 INFO - Successfully installed mozsystemmonitor 05:31:44 INFO - Cleaning up... 05:31:45 INFO - Return code: 0 05:31:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106875a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc194626e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106719d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106710b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:31:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:31:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:31:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 05:31:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:45 INFO - 'HOME': '/Users/cltbld', 05:31:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:45 INFO - 'LOGNAME': 'cltbld', 05:31:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:45 INFO - 'MOZ_NO_REMOTE': '1', 05:31:45 INFO - 'NO_EM_RESTART': '1', 05:31:45 INFO - 'PAGER': '/bin/cat', 05:31:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:45 INFO - 'PWD': '/builds/slave/test', 05:31:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:45 INFO - 'SHELL': '/bin/bash', 05:31:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 05:31:45 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 05:31:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:45 INFO - 'USER': 'cltbld', 05:31:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:45 INFO - 'XPC_FLAGS': '0x0', 05:31:45 INFO - 'XPC_SERVICE_NAME': '0', 05:31:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:45 INFO - Downloading/unpacking blobuploader==1.2.4 05:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:47 INFO - Downloading blobuploader-1.2.4.tar.gz 05:31:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:31:47 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:31:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:48 INFO - Downloading docopt-0.6.1.tar.gz 05:31:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:31:48 INFO - Installing collected packages: blobuploader, requests, docopt 05:31:48 INFO - Running setup.py install for blobuploader 05:31:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:31:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:31:49 INFO - Running setup.py install for requests 05:31:49 INFO - Running setup.py install for docopt 05:31:49 INFO - Successfully installed blobuploader requests docopt 05:31:49 INFO - Cleaning up... 05:31:49 INFO - Return code: 0 05:31:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106875a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc194626e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106719d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106710b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:31:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:31:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:31:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 05:31:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:49 INFO - 'HOME': '/Users/cltbld', 05:31:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:49 INFO - 'LOGNAME': 'cltbld', 05:31:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:49 INFO - 'MOZ_NO_REMOTE': '1', 05:31:49 INFO - 'NO_EM_RESTART': '1', 05:31:49 INFO - 'PAGER': '/bin/cat', 05:31:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:49 INFO - 'PWD': '/builds/slave/test', 05:31:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:49 INFO - 'SHELL': '/bin/bash', 05:31:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 05:31:49 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 05:31:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:49 INFO - 'USER': 'cltbld', 05:31:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:49 INFO - 'XPC_FLAGS': '0x0', 05:31:49 INFO - 'XPC_SERVICE_NAME': '0', 05:31:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:31:50 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-cvrV0O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:31:50 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-6QrBVt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:31:50 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-dWDnTe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:31:50 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-RZdf0h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:31:50 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-uQTdcy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:31:50 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-Of102m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:31:50 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-u3jePi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:31:50 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-3QKj2S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:31:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:31:50 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-L1UMJ5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:31:51 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-lcCvUg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:31:51 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-BYf2Kf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:31:51 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-OcPCIz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:31:51 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-B7j7Qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:31:51 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-pxiHY9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:51 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-rcqvdD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:31:51 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-5NiL5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:31:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:31:51 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-ZXcGmb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:31:51 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:31:51 INFO - Running setup.py install for manifestparser 05:31:51 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:31:52 INFO - Running setup.py install for mozcrash 05:31:52 INFO - Running setup.py install for mozdebug 05:31:52 INFO - Running setup.py install for mozdevice 05:31:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:31:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:31:52 INFO - Running setup.py install for mozfile 05:31:52 INFO - Running setup.py install for mozhttpd 05:31:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:31:52 INFO - Running setup.py install for mozinfo 05:31:52 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:31:52 INFO - Running setup.py install for mozInstall 05:31:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:31:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:31:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:31:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:31:53 INFO - Running setup.py install for mozleak 05:31:53 INFO - Running setup.py install for mozlog 05:31:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:31:53 INFO - Running setup.py install for moznetwork 05:31:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:31:53 INFO - Running setup.py install for mozprocess 05:31:53 INFO - Running setup.py install for mozprofile 05:31:53 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:31:53 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:31:53 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:31:53 INFO - Running setup.py install for mozrunner 05:31:53 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:31:53 INFO - Running setup.py install for mozscreenshot 05:31:54 INFO - Running setup.py install for moztest 05:31:54 INFO - Running setup.py install for mozversion 05:31:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:31:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:31:54 INFO - Cleaning up... 05:31:54 INFO - Return code: 0 05:31:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106875a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc194626e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106719d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106710b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:31:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:31:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:31:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 05:31:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:54 INFO - 'HOME': '/Users/cltbld', 05:31:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:54 INFO - 'LOGNAME': 'cltbld', 05:31:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:54 INFO - 'MOZ_NO_REMOTE': '1', 05:31:54 INFO - 'NO_EM_RESTART': '1', 05:31:54 INFO - 'PAGER': '/bin/cat', 05:31:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:54 INFO - 'PWD': '/builds/slave/test', 05:31:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:54 INFO - 'SHELL': '/bin/bash', 05:31:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 05:31:54 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 05:31:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:54 INFO - 'USER': 'cltbld', 05:31:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:54 INFO - 'XPC_FLAGS': '0x0', 05:31:54 INFO - 'XPC_SERVICE_NAME': '0', 05:31:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:31:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:31:54 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-7RBuRD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:31:54 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-L5IQvX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:31:54 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-78PhVQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:31:54 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:31:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:31:55 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-GJiUcU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:31:55 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-u8Ihm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:31:55 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-YavqOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:31:55 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-ov2ui3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:31:55 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-lB3h00-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:31:55 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-Le0fgS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:31:55 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-b1ziuP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:31:55 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-V3zEOB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:31:55 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-gqtrhc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:31:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:31:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:31:55 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-qJX6U_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:31:56 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-cLTsUC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:56 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-kifKjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:31:56 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-Odwf_L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:31:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:31:56 INFO - Running setup.py (path:/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/pip-j6h08V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:31:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:31:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:31:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:31:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:31:59 INFO - Downloading blessings-1.6.tar.gz 05:31:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:31:59 INFO - Installing collected packages: blessings 05:31:59 INFO - Running setup.py install for blessings 05:31:59 INFO - Successfully installed blessings 05:31:59 INFO - Cleaning up... 05:31:59 INFO - Return code: 0 05:31:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:31:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:31:59 INFO - Reading from file tmpfile_stdout 05:31:59 INFO - Current package versions: 05:31:59 INFO - blessings == 1.6 05:31:59 INFO - blobuploader == 1.2.4 05:31:59 INFO - docopt == 0.6.1 05:31:59 INFO - manifestparser == 1.1 05:31:59 INFO - mozInstall == 1.12 05:31:59 INFO - mozcrash == 0.17 05:31:59 INFO - mozdebug == 0.1 05:31:59 INFO - mozdevice == 0.48 05:31:59 INFO - mozfile == 1.2 05:31:59 INFO - mozhttpd == 0.7 05:31:59 INFO - mozinfo == 0.9 05:31:59 INFO - mozleak == 0.1 05:31:59 INFO - mozlog == 3.1 05:31:59 INFO - moznetwork == 0.27 05:31:59 INFO - mozprocess == 0.22 05:31:59 INFO - mozprofile == 0.28 05:31:59 INFO - mozrunner == 6.11 05:31:59 INFO - mozscreenshot == 0.1 05:31:59 INFO - mozsystemmonitor == 0.0 05:31:59 INFO - moztest == 0.7 05:31:59 INFO - mozversion == 1.4 05:31:59 INFO - psutil == 3.1.1 05:31:59 INFO - requests == 1.2.3 05:31:59 INFO - wsgiref == 0.1.2 05:31:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:31:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:31:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:31:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106875a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc194626e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106719d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106710b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:31:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:31:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:31:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 05:31:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:31:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:31:59 INFO - 'HOME': '/Users/cltbld', 05:31:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:31:59 INFO - 'LOGNAME': 'cltbld', 05:31:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:31:59 INFO - 'MOZ_NO_REMOTE': '1', 05:31:59 INFO - 'NO_EM_RESTART': '1', 05:31:59 INFO - 'PAGER': '/bin/cat', 05:31:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:31:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:31:59 INFO - 'PWD': '/builds/slave/test', 05:31:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:31:59 INFO - 'SHELL': '/bin/bash', 05:31:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 05:31:59 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 05:31:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:31:59 INFO - 'USER': 'cltbld', 05:31:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:31:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:31:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:31:59 INFO - 'XPC_FLAGS': '0x0', 05:31:59 INFO - 'XPC_SERVICE_NAME': '0', 05:31:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:32:00 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:32:00 INFO - Cleaning up... 05:32:00 INFO - Return code: 0 05:32:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106875a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc194626e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106719d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106710b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:32:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:32:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:32:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 05:32:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:00 INFO - 'HOME': '/Users/cltbld', 05:32:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:00 INFO - 'LOGNAME': 'cltbld', 05:32:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:00 INFO - 'MOZ_NO_REMOTE': '1', 05:32:00 INFO - 'NO_EM_RESTART': '1', 05:32:00 INFO - 'PAGER': '/bin/cat', 05:32:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:00 INFO - 'PWD': '/builds/slave/test', 05:32:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:00 INFO - 'SHELL': '/bin/bash', 05:32:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 05:32:00 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 05:32:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:00 INFO - 'USER': 'cltbld', 05:32:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:00 INFO - 'XPC_FLAGS': '0x0', 05:32:00 INFO - 'XPC_SERVICE_NAME': '0', 05:32:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:00 INFO - Downloading/unpacking jsonschema 05:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:32:02 INFO - Downloading/unpacking functools32 (from jsonschema) 05:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:03 INFO - Downloading functools32-3.2.3-2.tar.gz 05:32:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:32:03 INFO - warning: no files found matching '*.txt' 05:32:03 INFO - no previously-included directories found matching 'build' 05:32:03 INFO - no previously-included directories found matching 'dist' 05:32:03 INFO - no previously-included directories found matching '.git*' 05:32:03 INFO - Installing collected packages: jsonschema, functools32 05:32:03 INFO - Running setup.py install for functools32 05:32:03 INFO - warning: no files found matching '*.txt' 05:32:03 INFO - no previously-included directories found matching 'build' 05:32:03 INFO - no previously-included directories found matching 'dist' 05:32:03 INFO - no previously-included directories found matching '.git*' 05:32:03 INFO - Successfully installed jsonschema functools32 05:32:03 INFO - Cleaning up... 05:32:03 INFO - Return code: 0 05:32:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 05:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106875a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10687d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbc194626e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106719d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106710b20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 'VERSIONER_PYTHON_VERSION': '2.7', 'XPC_FLAGS': '0x0', 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 'MOZ_NO_REMOTE': '1', 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:32:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 05:32:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 05:32:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 05:32:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:03 INFO - 'HOME': '/Users/cltbld', 05:32:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:03 INFO - 'LOGNAME': 'cltbld', 05:32:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:03 INFO - 'MOZ_NO_REMOTE': '1', 05:32:03 INFO - 'NO_EM_RESTART': '1', 05:32:03 INFO - 'PAGER': '/bin/cat', 05:32:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:03 INFO - 'PWD': '/builds/slave/test', 05:32:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:03 INFO - 'SHELL': '/bin/bash', 05:32:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 05:32:03 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 05:32:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:03 INFO - 'USER': 'cltbld', 05:32:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:03 INFO - 'XPC_FLAGS': '0x0', 05:32:03 INFO - 'XPC_SERVICE_NAME': '0', 05:32:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:03 INFO - Downloading/unpacking flake8 05:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 05:32:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 05:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:06 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 05:32:06 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 05:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:06 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 05:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 05:32:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:32:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:32:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:32:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:32:07 INFO - no previously-included directories found matching 'docs/_build' 05:32:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 05:32:07 INFO - Running setup.py install for pep8 05:32:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 05:32:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 05:32:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 05:32:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 05:32:07 INFO - no previously-included directories found matching 'docs/_build' 05:32:07 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 05:32:07 INFO - Successfully installed flake8 mccabe pyflakes pep8 05:32:07 INFO - Cleaning up... 05:32:07 INFO - Return code: 0 05:32:07 INFO - Running post-action listener: _resource_record_post_action 05:32:07 INFO - Running post-action listener: _start_resource_monitoring 05:32:07 INFO - Starting resource monitoring. 05:32:07 INFO - ##### 05:32:07 INFO - ##### Running install step. 05:32:07 INFO - ##### 05:32:07 INFO - Running pre-action listener: _resource_record_pre_action 05:32:07 INFO - Running main action method: install 05:32:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:07 INFO - Reading from file tmpfile_stdout 05:32:07 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:32:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:32:08 INFO - Reading from file tmpfile_stdout 05:32:08 INFO - Output received: 05:32:08 INFO - Usage: mozinstall [options] installer 05:32:08 INFO - Options: 05:32:08 INFO - -h, --help show this help message and exit 05:32:08 INFO - -d DEST, --destination=DEST 05:32:08 INFO - Directory to install application into. [default: 05:32:08 INFO - "/builds/slave/test"] 05:32:08 INFO - --app=APP Application being installed. [default: firefox] 05:32:08 INFO - mkdir: /builds/slave/test/build/application 05:32:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:32:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:32:41 INFO - Reading from file tmpfile_stdout 05:32:41 INFO - Output received: 05:32:41 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:32:41 INFO - Running post-action listener: _resource_record_post_action 05:32:41 INFO - ##### 05:32:41 INFO - ##### Running run-tests step. 05:32:41 INFO - ##### 05:32:41 INFO - Running pre-action listener: _resource_record_pre_action 05:32:41 INFO - Running main action method: run_tests 05:32:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:32:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:32:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:32:41 INFO - 2016-03-15 05:32:41.845 screenresolution[1640:7426] starting screenresolution argv=screenresolution get 05:32:41 INFO - 2016-03-15 05:32:41.848 screenresolution[1640:7426] Display 0: 1600x1200x32@60 05:32:41 INFO - 2016-03-15 05:32:41.853 screenresolution[1641:7428] starting screenresolution argv=screenresolution list 05:32:41 INFO - Available Modes on Display 0 05:32:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:32:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:32:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:32:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:32:42 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:32:42 INFO - Intel Iris: 05:32:42 INFO - Chipset Model: Intel Iris 05:32:42 INFO - Type: GPU 05:32:42 INFO - Bus: Built-In 05:32:42 INFO - VRAM (Dynamic, Max): 1536 MB 05:32:42 INFO - Vendor: Intel (0x8086) 05:32:42 INFO - Device ID: 0x0a2e 05:32:42 INFO - Revision ID: 0x0009 05:32:42 INFO - Displays: 05:32:42 INFO - Display: 05:32:42 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:32:42 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:32:42 INFO - Display Serial Number: 1600x1200 60 05:32:42 INFO - Main Display: Yes 05:32:42 INFO - Mirror: Off 05:32:42 INFO - Online: Yes 05:32:42 INFO - Rotation: Supported 05:32:42 INFO - Return code: 0 05:32:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:32:42 INFO - Python 2.7.3 05:32:42 INFO - Return code: 0 05:32:42 INFO - grabbing minidump binary from tooltool 05:32:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:42 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106719d30>, 'level': 'warning'}, {'substr': 'Traceback (most recent call last)', 'level': 'error'}, {'substr': 'SyntaxError: ', 'level': 'error'}, {'substr': 'TypeError: ', 'level': 'error'}, {'substr': 'NameError: ', 'level': 'error'}, {'substr': 'ZeroDivisionError: ', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10653ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106710b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:32:42 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:32:42 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:32:42 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:32:42 INFO - Return code: 0 05:32:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:32:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:32:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:32:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:32:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:32:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 05:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 05:32:43 INFO - Return code: 0 05:32:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0200', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:32:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0200 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:32:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.UAQwe0HAqq/Render', 05:32:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:43 INFO - 'HOME': '/Users/cltbld', 05:32:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:43 INFO - 'LOGNAME': 'cltbld', 05:32:43 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:32:43 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:32:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:43 INFO - 'MOZ_NO_REMOTE': '1', 05:32:43 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:32:43 INFO - 'NO_EM_RESTART': '1', 05:32:43 INFO - 'PAGER': '/bin/cat', 05:32:43 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:43 INFO - 'PWD': '/builds/slave/test', 05:32:43 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:32:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:43 INFO - 'SHELL': '/bin/bash', 05:32:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners', 05:32:43 INFO - 'TMPDIR': '/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/', 05:32:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:43 INFO - 'USER': 'cltbld', 05:32:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:43 INFO - 'XPC_FLAGS': '0x0', 05:32:43 INFO - 'XPC_SERVICE_NAME': '0', 05:32:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:32:43 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0200', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:32:43 INFO - mozversion application_buildid: 20160315030230 05:32:43 INFO - mozversion application_changeset: 5e14887312d4523ab59c3f6c6c94a679cf42b496 05:32:43 INFO - mozversion application_display_name: Nightly 05:32:43 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:32:43 INFO - mozversion application_name: Firefox 05:32:43 INFO - mozversion application_remotingname: firefox 05:32:43 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:32:43 INFO - mozversion application_vendor: Mozilla 05:32:43 INFO - mozversion application_version: 48.0a1 05:32:43 INFO - mozversion platform_buildid: 20160315030230 05:32:43 INFO - mozversion platform_changeset: 5e14887312d4523ab59c3f6c6c94a679cf42b496 05:32:43 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:32:43 INFO - mozversion platform_version: 48.0a1 05:32:43 INFO - using testdate: 1458045163 05:32:43 INFO - actual date: 1458045163 05:32:43 INFO - starting webserver on 'localhost:49270' 05:32:43 INFO - SUITE-START | Running 2 tests 05:32:43 INFO - TEST-START | dromaeo_css 05:32:43 INFO - operating with platform_type : mac_ 05:32:43 INFO - Initialising browser for dromaeo_css test... 05:32:43 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/tmpFdIHe2/profile http://localhost:49270/getInfo.html) 05:32:46 INFO - PROCESS | 1662 | __metrics Screen width/height:1600/1200 05:32:46 INFO - PROCESS | 1662 | colorDepth:24 05:32:46 INFO - PROCESS | 1662 | Browser inner width/height: 1024/689 05:32:46 INFO - PROCESS | 1662 | __metrics 05:32:46 INFO - PROCESS | 1662 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:32:46 ERROR - PROCESS | 1662 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:32:47 INFO - TEST-INFO | 1662: exit 0 05:32:47 INFO - Browser initialized. 05:32:47 INFO - Running cycle 1/1 for dromaeo_css test... 05:32:47 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/tmpFdIHe2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:32:58 INFO - PROCESS | 1666 | RSS: Main: 243163136 05:32:58 INFO - PROCESS | 1666 | 05:33:50 INFO - PROCESS | 1666 | 1458045230062 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:36:00 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 05:36:02 INFO - PROCESS | 1666 | RSS: Main: 381399040 05:36:02 INFO - PROCESS | 1666 | 05:39:04 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 05:39:05 INFO - PROCESS | 1666 | RSS: Main: 372097024 05:39:05 INFO - PROCESS | 1666 | 05:42:07 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 05:42:07 INFO - PROCESS | 1666 | RSS: Main: 374964224 05:42:07 INFO - PROCESS | 1666 | 05:45:10 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 05:45:10 INFO - PROCESS | 1666 | RSS: Main: 336076800 05:45:10 INFO - PROCESS | 1666 | 05:48:13 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 05:48:14 INFO - PROCESS | 1666 | RSS: Main: 335048704 05:48:14 INFO - PROCESS | 1666 | 05:51:17 INFO - PROCESS | 1666 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 05:51:17 INFO - PROCESS | 1666 | RSS: Main: 412237824 05:51:17 INFO - PROCESS | 1666 | 05:51:17 INFO - PROCESS | 1666 | __start_tp_report 05:51:17 INFO - PROCESS | 1666 | _x_x_mozilla_page_load 05:51:17 INFO - PROCESS | 1666 | _x_x_mozilla_page_load_details 05:51:17 INFO - PROCESS | 1666 | |i|pagename|runs| 05:51:17 INFO - PROCESS | 1666 | |0;dojo.html;3379.6282408935;3413.214960559072;3413.573303337083;3430.091025878142;3496.37065328241;5612.887742245163;5662.886742265152;5688.687122208277;5694.202811606373;5722.513586345155;5677.545796336293;5695.544356451484;5730.942690573093;5799.217105690731;5828.912566311508;5113.437521872591;5121.769520371592;5139.897202055975;5158.9484105158845;5238.397584277819;5283.154695248761;5295.894082118355;5340.759665815048;5351.384590772072;5396.946030539703;5090.541851233388;5111.974440127813;5194.402643695967;5217.3217481727515;5226.2944502492055;5165.018646457161;5182.455842136559;5186.974065129688;5189.481051894818;5194.92207616886;5106.897862042775;5150.969806038807;5154.12379895415;5164.1995490699;5166.844994650129;5510.393856675762;5581.330240371181;5592.412796656333;5623.606347555673;5644.8871022579315;6065.831970971708;6075.936711075588;6076.690857474176;6080.212144473554;6089;6039.667818269993;6113.223004260975;6121.755129794848;6127.846803829895;6133.304060594571;5664.150377443417;5707.5148612368;5732.226149469851;5753.971230143822;5764.106563482667;6213.316535181127;6259.906101408483;6263.968680156661;6264.5301602380005;6265.342139075331;6015.909761353583;6137.294211165773;6154.5076393888385;6155.815325540241;6169.2288463942;6123.326434092335;6138.6336396323695;6140.109684095781;6150.969245153835;6164.075388691732;6172.69136543171;6183.536234782409;6197.225346831646;6204.534659900525;6207.286162091327;6092.268927728701;6161.476274516626;6191.845203869849;6211.440970312694;6216;4867.853964381075;4881.95118048822;4892.3884514435695;4895.7062576245535;4949.282354058641;4354.608085272277;4382.2112019836095;4393;4408.911821763547;4439.134368798118;5763.596548241583;5772.682502462321;5777.133429985536;5779.508741756998;5786.971065144648;6110.801781737226;6118.908216376758;6145.293291271471;6197.163382943245;6232.283287422005;5778.3354914184565;5808.751118509541;5821.2141360916585;5826.980278451254;5829.300483941955;5349.946500535023;5351.331083614548;5351.438098999627;5355.30381050461;5359.892802143935;6182.845428864224;6257.4994000480765;6329.49364050884;6341.936580634135;6341.985282354801;6188.288346840171;6208.844778880564;6214.285357183981;6222.222222222223;6223;6298.937010629835;6319.146915166394;6320.525960553069;6334.746610135543;6350.904736428864;6048.274207095177;6110.042400473335;6112.663803490851;6158.291796443466;6178.474829639531;5973.760672742217;6146.53900957439;6178.073289006685;6188.257409110935;6189.1025801257665;5937.317208521075;6061.818145455643;6065.215230142197;6078.270607527125;6140.385961403824;6000.819975400745;6047.183630210041;6085.9695701521205;6118.449339559461;6124.448799608057;5878.941210587839;5890.352061273171;5894.351621321565;5909.468147866713;5912.46787789101;5030.99380123984;5862.296524417097;6027.156198132177;6044.304904935812;6045.335013148462;5904.911426328523;5911.852203694942;5927.110933360031;5929.881402372014;5967.46292833647 05:51:17 INFO - PROCESS | 1666 | |1;ext.html;504.7249249159208;579.6869690367205;580.1558732044875;632.9493640508758;638.5944924972642;31978.840105799467;39910.60089399105;39911.401328980086;39961.400578991335;39978;43256.35115473263;43573.91065223371;43680.34479482802;43704.56295437045;43708.78145609275;9419.152276295115;9638;9638.469884156404;9656.179224765903;9660.227181825472;9493.430394176337;9662.613495460173;9665.130138287554;9726;9816.460094694788;8385.538795366252;9722.173615242713;9807;9816.067473590034;9816.411015339067;9696.030396960317;9771.804563908752;9772.804543909082;9776;9777.755556111082;9608.567614457366;9736.172425343855;9759.316847820655;9764.170045546138;9764.658236961743;34395.65604343949;41866.1626767466;42309;42484.93787655303;42498.78750606258;3213.4858422652496;3268.2809781847955;3269.9182520436943;3336.1492819331156;3491.2668339648703;22644.773552264433;27267.727322726718;28860;28897.277568060756;28943.710562894314;2712.9321766955786;2833.8158019728653;2847.700991395915;2852.3724780548246;2935.9559606605703;405719;407515.99999999703;407537;408332;408481.9575902131;67652.3234767646;67859;72218.63890680514;72331.63834180901;72401.99999999895;76248;76434.61782691051;76452.61773691207;76513;76684.61657691788;15626;15655.765163522556;17106.914465427843;17112.144392780312;17130.571735706457;11772.764544709058;11882.28706277626;11906.46420911061;13043.217406955613;13279.93360033213;16381.594392460773;17346.392876249272;21168.682469762967;21818;21847.672284915738;9478.336516443782;9573.18627916621;9629.264356480146;9700.757481062888;9715.757106072404;795.7095660084028;840.9705660301983;959.0313783079001;1035.9792804144026;1043.3166276089173;29811;29903.401931961238;29921.803127874642;30402.69597304043;30576.08271751851;1083.2687935643567;1096.4923230557984;1108.1135091926426;1167.8365028895962;1211.854577450694;14884.851151488347;14950.925245373703;14965.551033469013;15170.393184272727;15171.089734615958;633539;638530;643904;644071;644073;61492.69253653793;61991;62044.37955620476;62165.378346216865;62254.0661890072;1291.0962326371578;1357.7216670582507;1382.700261753948;1488.0848278308763;1495.53638372105;26434.735652643998;29342.55986160252;29528.11415657534;29724.405511890072;29824.701752982193;46154.76922615366;50524.231651892005;51482.742586286826;52023.47976520186;52093.21860172025;402291;406282;406428;406563;406935;28147.296317592223;33825.49261761125;34189.82905085458;34204;34224.486632701024;41477.476044689734;42486.36270456007;42537.36193957031;42562.78718606387;43783;34655.480167796995;35359;35468.82265588759;36002.8199858999;36300.81849590735;35072.64927350694;35126.64873351234;35762;35932.10169745777;37126.628733712314;36897.26205475822;37195.25609487849;37924.62075379211;38784.8364549064;38801;26715.599266010635;30079;31759.52360714545;32430.513542297358;32606.51090233601;24016.39959001039;24295.392615184763;24636.13773517918;24751.133710320053;24987.50024999526 05:51:17 INFO - PROCESS | 1666 | |2;jquery.html;295.97484213841824;361.3441603489667;367.99080022999436;369.59160128058494;376.29820384982014;19071.61856762864;19991;20718.067686954084;21174.89412552935;21213.151473941063;19563.902180489113;19866.503337416572;20704.378868633965;20722.481937951557;20750.066247018884;5215.504527069922;5350.143976963686;5406.675599464044;5416.079266524681;5417.024935511607;3197.6322722886816;4041.4948131483566;5325.680459172443;5711.143328500737;5967.075103358986;5918.88162236755;5957.463828255456;5961.701914904259;5964.821055368346;5966.343702192756;5930.733117009723;6244.9687751561405;6251.687415629201;6390.265119511269;6432.388923052303;5678.37537870838;5680.914786278167;5682.17608446777;5693.117566777156;5697.31632204134;17530.91234543832;24450.755492445027;25344.619830702555;25384.746152538424;25421.745782542308;1831.1942745192073;1956.4130760771711;1988.4233572264027;2039.8164165225053;2055.660815965379;9605.51972401384;9803.411795292306;10298.17614590831;12695.238285702888;14923.806095512442;1765.8940463572226;1804.5759246577045;1805.5666640006305;1876.249500199931;1877.633861397028;104670.47664761628;109667.45166274198;110491.34262986062;110590.34114488288;110832.4458377711;11407.030402415887;11429.942850285695;11447.027002704863;11454.828177577343;11551.249168804;13759.312034398441;13841.238731869844;13880.583582492542;13885.722285554233;13901.443942242398;8508.787280317918;8679.826403471896;8695.652173912973;8784.077671844492;8799.076097009849;8894.332925030649;8905.154010369004;8923.866142007875;8984.371094023487;9020.81958360829;4415.470143582791;4501.594856462869;4508.346289787963;4551.431071116111;4576.588107070313;1743.747156662277;1822.699254622999;1835.9632807343778;1870.9906450467934;1948.9707654385195;673.723773252964;889.4840992224495;923.1276443760715;970.0784254957819;980.6861804222723;16137.193140342935;16897.239624216938;19978.400647980583;20380.28668996578;20741;942.0579420579421;976.2677991506371;1004.7237009822211;1042.4370839746603;1064.9520771565299;10849.240553161202;11058;11062.115030797679;11074;11083;603590;620991;624911;638479;643148.5685143182;121419;124124.37937810253;128597;131559.68440315666;132240.75953544056;1017.4302390661253;1053.1101219469535;1066.3335415365398;1072.6835583502886;1073.6617965340893;17360.652786944444;17974;18032.2787088515;18370.265189392274;18740.156692949124;50282.497175029246;53712.1943170845;55905.88188236294;56677;56912.71543642255;77210.61394692991;77301;78096.60951695433;79555.20444795478;80111;7478.915557244278;7617.124030736536;7768.339691126092;8011.759647210593;8041.8391632168195;12146.453409596412;12544.686382840502;12696.6825829355;12852.55016074433;12900.935495322463;10814.675559733221;11032.889671103507;11190.048845848194;11223.102151827998;11246.831297530707;10617.362958222531;10644.787104258026;10933.507992140532;11039.779204416027;11564.421778910853;10040.397576145455;10652.520636571528;11229.887701122883;11255.324680519196;11285.32288062686;7599.392048636207;7781.766547003599;7837.13791482925;7894.605269736376;8207.425480216327;8346.290565302017;10316.690499285034;10540.15678745714;10659.09397701204;11189.944050279697 05:51:17 INFO - PROCESS | 1666 | |3;mootools.html;1447.51508244738;1597.8721702263817;1637.7297745871936;1925.451246394777;2057.9897100514495;7911.723089691862;8552.786180345487;8766.167214114665;8766.561671916395;8783.956080219607;8581.098984606604;8702.216800487955;8708.085651006648;8708.303335733142;8709.99835018973;2187.3765976696645;2411.1801987324393;2478.095495144268;2484.31681287646;2513.183215454975;2457.7050753909466;2490.651308816767;2504.524140413325;2505.5991041433376;2505.6116301973225;2433.245693834917;2483.4163971466783;2495.737947515512;2496.8751562421808;2499.550080985422;2189.8467107302495;2421.624648179535;2486.8383555069045;2487.129504673368;2492.239866840613;1996.4509759816021;2464.642626819119;2504.273760609421;2506.0101260002198;2507.9749202507924;8535.146485351477;8736.170063843925;8737.126287371211;8739.519326437043;8748.25639820616;5257.08001099806;5312.92030619541;5457.617966742329;5457.727113644302;5465.562754979632;3610.7291953103622;3677.595464498903;3738.1776009277914;3747.3442147624055;3781.489498917666;1017.4048181813648;1021.3055122516686;1064.3294724323705;1073.098597178374;1079.6599071292517;12001.219920705213;12003.879961200364;12007.099467539969;12015.158938874283;12019.939900300442;4939.259111133359;4966.801327946914;4975.875603109951;4993.975030124826;5066.695998240118;8343.916560834436;10158.796824063478;10195.745106372251;10198.592056317664;10224;5504.339479262514;5527.944720552743;5536.114221724585;5537.003339398947;5550.5282051026115;3983.521977362735;4420.734755914591;4539.750313732777;4968.30443737877;4973.328600638867;3882.776925268531;3961.900952476211;3983.7410568312966;4015.5181378234797;4021.4369988201674;1314.8619394963391;1317.8220940173146;1318.6241921052454;1326.0916272353468;1326.2241588670543;1103.85098011769;1127.1996882213557;1236.3076677060874;1395.8534353892899;1400.5588239704462;8277.58612069394;8291.005079390512;8333.374996875258;8340.249377556049;8343.415960882801;513.2122192434595;529.6927781886496;532.2442132172324;543.13641310316;543.8450041738085;6298.527610429144;6305.117283580303;6317.368263173737;6338.049292606146;6367.522435817332;10324.328918620266;10675.83986240207;10769.192310576738;10825.13398928084;10837.783244335227;10280.434576098236;10555.525001374957;10579.31234469757;10624;10744.838827417596;6986.790396288119;8366.247037766509;8439.409241353047;8492.150784921458;8498.23515883561;7764.572948487661;7965.56189409588;7985.041794984407;8004.95997520032;8009.879851802344;9352.812943741223;9603.231741460806;9617.711468655672;9685.951570242103;9764.707058788248;9854.458004809518;9980.451075190935;10091.495425228562;10210.97890210973;10228.590856365661;6266.216722909637;6722.294159113419;6815.829604259933;7371.926280737124;7580.8483830324185;8266.628001739817;8319.126491718282;8325.916740832514;8330.458520196167;8335.624896879775;7183.497155199086;7258.600776957318;7285.744998925013;7387.852242955219;7439.442041846992;6183.196184495987;7173.390261827803;7259.346658800522;7372.41020718352;7412.444066695128;7673.693052278069;7758.379329653501;7766.339861111643;7790.571518566307;7800.1419843816;6916.377526022682;7026.156861176692;7033.085698859116;7038.40173585251;7043.36609705129;6960.025596416404;7111.82220444493;7117.644117794193;7119.893201601876;7142.178649455379 05:51:17 INFO - PROCESS | 1666 | |4;prototype.html;328.1451818014074;329.0703761872709;336.0406040753647;336.3508428732545;339.80631040307037;5283;6575.243846957601;6577.34226577342;6586.934130658692;6600.207975043001;5900.262467191601;6548;6555.77054803082;6558.540902136852;6568.934310656892;4643.558861908114;4777.307290442884;4785.760711964405;4795;4918.58192053675;4623.930641040387;4728.952710472903;4803.855884323476;4811.278308253755;4841.3464182335465;3596.874109406171;4798.160321943664;4814.277858321262;4828.903421931559;4829.975850120744;4837.177679794426;4840.5159484051665;4843.15244832153;4853.417589889201;4855.660103792736;3980.86066987654;4072.9185416291803;4153.231652144333;4159.854405095837;4169.020280234173;5343.706096164709;5995.381247063268;6190.226221722285;6288.276848162428;6311.779087731908;4749.907521270093;5666.801661941812;5666.979943610148;5674.290713660793;5696.601237913348;6812.761553345609;6927.272636373159;6931.677887907557;6945.062416573748;6948.826279343007;4635.745034023127;4658.976705116486;4659.58063774262;4665.790039448233;4670.486246512881;7044.36600705939;7359.521631093961;7362.8527429451115;7381.852362952764;7393.334599885982;4565.360849481075;4601.010782681673;4620.422447194101;4623.445186577632;4633.976830115827;4673.789679464432;4682.157211701926;4682.391289132459;4694.554017368345;4697.600703940135;5534.695591742412;5542.2795036644975;5543.417941116206;5549.72251387429;5552.639603297137;6682.198136223684;6956.79129626112;6994.370506654425;7002.929970700329;7006.264342244093;1448.2107251547932;1661.46002549172;1666.658335041338;1669.8246684098237;1689.1132155618152;1095.2771171027084;1104.8895110488886;1122.45560902962;1128.5993472317373;1129.175701737736;5581.413951535112;6396.42432181106;6451.64515451751;6603.240627327918;6632.535722499379;7060.752873649398;7188.856222875618;7219.783406497813;7236.493445458767;7244.166920804069;5421.945780542144;6637.070810086591;6650.800475985729;6675.766348177791;6687.063811066455;3774.6225377462033;3831.1762970961377;3832.137769001952;3832.6550610445192;3840.1743625120735;7371.078615173104;7613.885791713129;7616.9238307617325;7618.542887426772;7642.961785191039;7438.66526006331;7465.776026719207;7482.176960534337;7482.513636613603;7515.361194298436;6640.568363056386;7183.497155199086;7604.201558836243;7604.505707129019;7610.048743907012;7191.532550384209;7195.424366050808;7201.531900426456;7203.531770434905;7210.351068403869;6839.555428897106;7086.185088714864;7101;7116.288371163049;7151.53515021522;6118.816435506942;7553.660085296065;7607.125180604301;7620.009398778124;7621.199774023869;3902.804859756944;4772.6181905448175;4786.521347865186;4791.520847915181;4797.784099715452;7171.1394632644415;7188.856222875409;7194.532355396883;7196.640167991684;7209.71161153548;6661.866762664817;6949.965250173716;6962.582245065312;6965.407940325129;6968.442524598121;6921.688524016532;6962.094927659372;6969.4424446045205;6969.965150174216;6979.965100174467;6781.220159681699;6794.76218332356;6799.762008329685;6806.625635589892;6809.795706128824;6947.687354068978;6954.652267386711;6954.9652251740445;6960.930390696029;6966.303369662993;6546.149000629887;6779.6271205084195;6798.150231221098;6801.761938332134;6908.654567271717 05:51:17 INFO - PROCESS | 1666 | |5;yui.html;696.87804634189;762.9618519074045;767.3362541401689;774.5004472115482;787.063394560473;12376.938115309422;15139.545813625595;15379.231038448088;15388.923055384721;15430.5370838875;13944.233067181302;14584.343704533296;14607.123572585653;14608.707825843478;14645.41418343265;747.5253214208989;753.9132999705022;924.3437159616647;927.5223260021078;934.4626839567242;919.4023884475077;933.9719808405724;935.6491315756591;935.6725146198844;936.8688383626297;974.790420059687;993.7913038261973;994;996.6511720897701;997.4065431068502;783.8353945671416;792.3977776889548;794.7973266816982;943.3302355327656;971.3928794503436;727.2109760909419;731.0386841303668;732.4835990626596;732.5860888597925;732.6080546907378;15321.616959575987;15351.4626988056;15352.692946141126;15364.078155310717;15371.000884942554;12611.684707882285;12862.035347348892;12909.289989050598;12968.935155324258;13061.542846000439;10069.647562335284;10225.948870255601;10307.639232626898;10516.474176291154;11066.114710823114;3577.3560759063357;3651.8904432867057;3662.047867554428;3731.5149030626117;3750.9624903750887;85035.57482212549;86383.13616863814;86947;87138;87658;9118.088191180961;9167.495787731605;9216.769580760401;9388.718338449857;9966.900330996743;20039.499012524804;20050.899745501472;20055.197792088155;20085.899570502053;20099.095540700702;7414.740484083031;7441.516301440389;7581.924180758232;7632.160462349138;7700.191479894643;4061.4313996039987;4064.532578753481;4131.586841315904;4135.8966025848995;4211.4525111735275;3378.391889459921;3654.543182102237;3661.7253705972157;3668.0646435158865;3672.3573374659327;570.2216474512261;646.4698946863621;663.6548994522917;664.0603545982477;669.5547460938421;578.3943335274561;584.2579923497135;602.6956387024525;612.4671535763825;619.7768803230833;7599.734009309758;7959.920400796033;8060.193980601893;8105.351571874236;8248.8350232995;564.9180868774005;574.5489790514426;607.8389226854798;619.2599843187438;620.7796232337546;3750.718696097804;3784.8675296364495;3825.6556909877686;3858.2862170498547;4081.3673880548563;94597.05402945883;96039;96833;97649.51175244078;97965.51017244869;78476;79375.20624793677;79394.20605793867;79794.6010269945;80622.59688701636;67530;68580.6570967142;68750.03124546813;69357.65321173564;69972.65013675;6397.424231819158;7617.27635874591;7671.347935425328;7704.576248306173;7732.536047837148;37065;49334;49496.50503494919;49532;50355.74822125866;69927;70431.29568704247;70748.64625676839;70916;71743.28256717366;9799.314048016855;9857;10077.949610251902;10626.468676565986;10806.891931080589;11938.64184074479;12013.81979270329;12142;12286.938565307117;12427.813582796085;11109.222354435113;11495.942520287344;11516.136289778467;11590.768184636428;11667.59163429276;11374.715632109264;11524.842149362128;11626.360550169484;11662.766744665229;12026.699332516757;11228.326300422;11248.381339026431;11365.602203922823;11456.255343402652;11643.76712465729;8987.033633066616;8996.280297576048;9282.860757088783;9289.62841486333;9370.203532699798;6948.826279343057;8811.911880881366;8870.467771933705;9311.44131352121;9501.762455938657 05:51:17 INFO - PROCESS | 1666 | __end_tp_report 05:51:17 INFO - PROCESS | 1666 | __start_cc_report 05:51:17 INFO - PROCESS | 1666 | _x_x_mozilla_cycle_collect,1201 05:51:17 INFO - PROCESS | 1666 | __end_cc_report 05:51:17 INFO - PROCESS | 1666 | __startTimestamp1458046277483__endTimestamp 05:51:17 INFO - PROCESS | 1666 | 05:51:17 INFO - PROCESS | 1666 | ------- Summary: start ------- 05:51:17 INFO - PROCESS | 1666 | Number of tests: 6 05:51:17 INFO - PROCESS | 1666 | 05:51:17 INFO - PROCESS | 1666 | [#0] dojo.html Cycles:165 Average:5711.15 Median:5911.85 stddev:618.87 (10.5%) stddev-sans-first:593.13 05:51:17 INFO - PROCESS | 1666 | Values: 3379.6 3413.2 3413.6 3430.1 3496.4 5612.9 5662.9 5688.7 5694.2 5722.5 5677.5 5695.5 5730.9 5799.2 5828.9 5113.4 5121.8 5139.9 5158.9 5238.4 5283.2 5295.9 5340.8 5351.4 5396.9 5090.5 5112.0 5194.4 5217.3 5226.3 5165.0 5182.5 5187.0 5189.5 5194.9 5106.9 5151.0 5154.1 5164.2 5166.8 5510.4 5581.3 5592.4 5623.6 5644.9 6065.8 6075.9 6076.7 6080.2 6089.0 6039.7 6113.2 6121.8 6127.8 6133.3 5664.2 5707.5 5732.2 5754.0 5764.1 6213.3 6259.9 6264.0 6264.5 6265.3 6015.9 6137.3 6154.5 6155.8 6169.2 6123.3 6138.6 6140.1 6151.0 6164.1 6172.7 6183.5 6197.2 6204.5 6207.3 6092.3 6161.5 6191.8 6211.4 6216.0 4867.9 4882.0 4892.4 4895.7 4949.3 4354.6 4382.2 4393.0 4408.9 4439.1 5763.6 5772.7 5777.1 5779.5 5787.0 6110.8 6118.9 6145.3 6197.2 6232.3 5778.3 5808.8 5821.2 5827.0 5829.3 5349.9 5351.3 5351.4 5355.3 5359.9 6182.8 6257.5 6329.5 6341.9 6342.0 6188.3 6208.8 6214.3 6222.2 6223.0 6298.9 6319.1 6320.5 6334.7 6350.9 6048.3 6110.0 6112.7 6158.3 6178.5 5973.8 6146.5 6178.1 6188.3 6189.1 5937.3 6061.8 6065.2 6078.3 6140.4 6000.8 6047.2 6086.0 6118.4 6124.4 5878.9 5890.4 5894.4 5909.5 5912.5 5031.0 5862.3 6027.2 6044.3 6045.3 5904.9 5911.9 5927.1 5929.9 5967.5 05:51:17 INFO - PROCESS | 1666 | 05:51:17 INFO - PROCESS | 1666 | [#1] ext.html Cycles:180 Average:63729.87 Median:39936.40 stddev:132652.00 (332.2%) stddev-sans-first:132939.19 05:51:17 INFO - PROCESS | 1666 | Values: 504.7 579.7 580.2 632.9 638.6 31978.8 39910.6 39911.4 39961.4 39978.0 43256.4 43573.9 43680.3 43704.6 43708.8 9419.2 9638.0 9638.5 9656.2 9660.2 9493.4 9662.6 9665.1 9726.0 9816.5 8385.5 9722.2 9807.0 9816.1 9816.4 9696.0 9771.8 9772.8 9776.0 9777.8 9608.6 9736.2 9759.3 9764.2 9764.7 34395.7 41866.2 42309.0 42484.9 42498.8 3213.5 3268.3 3269.9 3336.1 3491.3 22644.8 27267.7 28860.0 28897.3 28943.7 2712.9 2833.8 2847.7 2852.4 2936.0 405719.0 407516.0 407537.0 408332.0 408482.0 67652.3 67859.0 72218.6 72331.6 72402.0 76248.0 76434.6 76452.6 76513.0 76684.6 15626.0 15655.8 17106.9 17112.1 17130.6 11772.8 11882.3 11906.5 13043.2 13279.9 16381.6 17346.4 21168.7 21818.0 21847.7 9478.3 9573.2 9629.3 9700.8 9715.8 795.7 841.0 959.0 1036.0 1043.3 29811.0 29903.4 29921.8 30402.7 30576.1 1083.3 1096.5 1108.1 1167.8 1211.9 14884.9 14950.9 14965.6 15170.4 15171.1 633539.0 638530.0 643904.0 644071.0 644073.0 61492.7 61991.0 62044.4 62165.4 62254.1 1291.1 1357.7 1382.7 1488.1 1495.5 26434.7 29342.6 29528.1 29724.4 29824.7 46154.8 50524.2 51482.7 52023.5 52093.2 402291.0 406282.0 406428.0 406563.0 406935.0 28147.3 33825.5 34189.8 34204.0 34224.5 41477.5 42486.4 42537.4 42562.8 43783.0 34655.5 35359.0 35468.8 36002.8 36300.8 35072.6 35126.6 35762.0 35932.1 37126.6 36897.3 37195.3 37924.6 38784.8 38801.0 26715.6 30079.0 31759.5 32430.5 32606.5 24016.4 24295.4 24636.1 24751.1 24987.5 05:51:17 INFO - PROCESS | 1666 | 05:51:17 INFO - PROCESS | 1666 | [#2] jquery.html Cycles:180 Average:35443.37 Median:20720.27 stddev:104143.83 (502.6%) stddev-sans-first:104402.54 05:51:17 INFO - PROCESS | 1666 | Values: 296.0 361.3 368.0 369.6 376.3 19071.6 19991.0 20718.1 21174.9 21213.2 19563.9 19866.5 20704.4 20722.5 20750.1 5215.5 5350.1 5406.7 5416.1 5417.0 3197.6 4041.5 5325.7 5711.1 5967.1 5918.9 5957.5 5961.7 5964.8 5966.3 5930.7 6245.0 6251.7 6390.3 6432.4 5678.4 5680.9 5682.2 5693.1 5697.3 17530.9 24450.8 25344.6 25384.7 25421.7 1831.2 1956.4 1988.4 2039.8 2055.7 9605.5 9803.4 10298.2 12695.2 14923.8 1765.9 1804.6 1805.6 1876.2 1877.6 104670.5 109667.5 110491.3 110590.3 110832.4 11407.0 11429.9 11447.0 11454.8 11551.2 13759.3 13841.2 13880.6 13885.7 13901.4 8508.8 8679.8 8695.7 8784.1 8799.1 8894.3 8905.2 8923.9 8984.4 9020.8 4415.5 4501.6 4508.3 4551.4 4576.6 1743.7 1822.7 1836.0 1871.0 1949.0 673.7 889.5 923.1 970.1 980.7 16137.2 16897.2 19978.4 20380.3 20741.0 942.1 976.3 1004.7 1042.4 1065.0 10849.2 11058.0 11062.1 11074.0 11083.0 603590.0 620991.0 624911.0 638479.0 643148.6 121419.0 124124.4 128597.0 131559.7 132240.8 1017.4 1053.1 1066.3 1072.7 1073.7 17360.7 17974.0 18032.3 18370.3 18740.2 50282.5 53712.2 55905.9 56677.0 56912.7 77210.6 77301.0 78096.6 79555.2 80111.0 7478.9 7617.1 7768.3 8011.8 8041.8 12146.5 12544.7 12696.7 12852.6 12900.9 10814.7 11032.9 11190.0 11223.1 11246.8 10617.4 10644.8 10933.5 11039.8 11564.4 10040.4 10652.5 11229.9 11255.3 11285.3 7599.4 7781.8 7837.1 7894.6 8207.4 8346.3 10316.7 10540.2 10659.1 11189.9 05:51:17 INFO - PROCESS | 1666 | 05:51:17 INFO - PROCESS | 1666 | [#3] mootools.html Cycles:180 Average:6033.82 Median:2922.58 stddev:3204.52 (109.6%) stddev-sans-first:3194.97 05:51:17 INFO - PROCESS | 1666 | Values: 1447.5 1597.9 1637.7 1925.5 2058.0 7911.7 8552.8 8766.2 8766.6 8784.0 8581.1 8702.2 8708.1 8708.3 8710.0 2187.4 2411.2 2478.1 2484.3 2513.2 2457.7 2490.7 2504.5 2505.6 2505.6 2433.2 2483.4 2495.7 2496.9 2499.6 2189.8 2421.6 2486.8 2487.1 2492.2 1996.5 2464.6 2504.3 2506.0 2508.0 8535.1 8736.2 8737.1 8739.5 8748.3 5257.1 5312.9 5457.6 5457.7 5465.6 3610.7 3677.6 3738.2 3747.3 3781.5 1017.4 1021.3 1064.3 1073.1 1079.7 12001.2 12003.9 12007.1 12015.2 12019.9 4939.3 4966.8 4975.9 4994.0 5066.7 8343.9 10158.8 10195.7 10198.6 10224.0 5504.3 5527.9 5536.1 5537.0 5550.5 3983.5 4420.7 4539.8 4968.3 4973.3 3882.8 3961.9 3983.7 4015.5 4021.4 1314.9 1317.8 1318.6 1326.1 1326.2 1103.9 1127.2 1236.3 1395.9 1400.6 8277.6 8291.0 8333.4 8340.2 8343.4 513.2 529.7 532.2 543.1 543.8 6298.5 6305.1 6317.4 6338.0 6367.5 10324.3 10675.8 10769.2 10825.1 10837.8 10280.4 10555.5 10579.3 10624.0 10744.8 6986.8 8366.2 8439.4 8492.2 8498.2 7764.6 7965.6 7985.0 8005.0 8009.9 9352.8 9603.2 9617.7 9686.0 9764.7 9854.5 9980.5 10091.5 10211.0 10228.6 6266.2 6722.3 6815.8 7371.9 7580.8 8266.6 8319.1 8325.9 8330.5 8335.6 7183.5 7258.6 7285.7 7387.9 7439.4 6183.2 7173.4 7259.3 7372.4 7412.4 7673.7 7758.4 7766.3 7790.6 7800.1 6916.4 7026.2 7033.1 7038.4 7043.4 6960.0 7111.8 7117.6 7119.9 7142.2 05:51:17 INFO - PROCESS | 1666 | 05:51:17 INFO - PROCESS | 1666 | [#4] prototype.html Cycles:180 Average:5693.15 Median:6563.74 stddev:1812.55 (27.6%) stddev-sans-first:1772.34 05:51:17 INFO - PROCESS | 1666 | Values: 328.1 329.1 336.0 336.4 339.8 5283.0 6575.2 6577.3 6586.9 6600.2 5900.3 6548.0 6555.8 6558.5 6568.9 4643.6 4777.3 4785.8 4795.0 4918.6 4623.9 4729.0 4803.9 4811.3 4841.3 3596.9 4798.2 4814.3 4828.9 4830.0 4837.2 4840.5 4843.2 4853.4 4855.7 3980.9 4072.9 4153.2 4159.9 4169.0 5343.7 5995.4 6190.2 6288.3 6311.8 4749.9 5666.8 5667.0 5674.3 5696.6 6812.8 6927.3 6931.7 6945.1 6948.8 4635.7 4659.0 4659.6 4665.8 4670.5 7044.4 7359.5 7362.9 7381.9 7393.3 4565.4 4601.0 4620.4 4623.4 4634.0 4673.8 4682.2 4682.4 4694.6 4697.6 5534.7 5542.3 5543.4 5549.7 5552.6 6682.2 6956.8 6994.4 7002.9 7006.3 1448.2 1661.5 1666.7 1669.8 1689.1 1095.3 1104.9 1122.5 1128.6 1129.2 5581.4 6396.4 6451.6 6603.2 6632.5 7060.8 7188.9 7219.8 7236.5 7244.2 5421.9 6637.1 6650.8 6675.8 6687.1 3774.6 3831.2 3832.1 3832.7 3840.2 7371.1 7613.9 7616.9 7618.5 7643.0 7438.7 7465.8 7482.2 7482.5 7515.4 6640.6 7183.5 7604.2 7604.5 7610.0 7191.5 7195.4 7201.5 7203.5 7210.4 6839.6 7086.2 7101.0 7116.3 7151.5 6118.8 7553.7 7607.1 7620.0 7621.2 3902.8 4772.6 4786.5 4791.5 4797.8 7171.1 7188.9 7194.5 7196.6 7209.7 6661.9 6950.0 6962.6 6965.4 6968.4 6921.7 6962.1 6969.4 6970.0 6980.0 6781.2 6794.8 6799.8 6806.6 6809.8 6947.7 6954.7 6955.0 6960.9 6966.3 6546.1 6779.6 6798.2 6801.8 6908.7 05:51:17 INFO - PROCESS | 1666 | 05:51:17 INFO - PROCESS | 1666 | [#5] yui.html Cycles:180 Average:18523.36 Median:655.06 stddev:26579.65 (4057.6%) stddev-sans-first:26620.51 05:51:17 INFO - PROCESS | 1666 | Values: 696.9 763.0 767.3 774.5 787.1 12376.9 15139.5 15379.2 15388.9 15430.5 13944.2 14584.3 14607.1 14608.7 14645.4 747.5 753.9 924.3 927.5 934.5 919.4 934.0 935.6 935.7 936.9 974.8 993.8 994.0 996.7 997.4 783.8 792.4 794.8 943.3 971.4 727.2 731.0 732.5 732.6 732.6 15321.6 15351.5 15352.7 15364.1 15371.0 12611.7 12862.0 12909.3 12968.9 13061.5 10069.6 10225.9 10307.6 10516.5 11066.1 3577.4 3651.9 3662.0 3731.5 3751.0 85035.6 86383.1 86947.0 87138.0 87658.0 9118.1 9167.5 9216.8 9388.7 9966.9 20039.5 20050.9 20055.2 20085.9 20099.1 7414.7 7441.5 7581.9 7632.2 7700.2 4061.4 4064.5 4131.6 4135.9 4211.5 3378.4 3654.5 3661.7 3668.1 3672.4 570.2 646.5 663.7 664.1 669.6 578.4 584.3 602.7 612.5 619.8 7599.7 7959.9 8060.2 8105.4 8248.8 564.9 574.5 607.8 619.3 620.8 3750.7 3784.9 3825.7 3858.3 4081.4 94597.1 96039.0 96833.0 97649.5 97965.5 78476.0 79375.2 79394.2 79794.6 80622.6 67530.0 68580.7 68750.0 69357.7 69972.7 6397.4 7617.3 7671.3 7704.6 7732.5 37065.0 49334.0 49496.5 49532.0 50355.7 69927.0 70431.3 70748.6 70916.0 71743.3 9799.3 9857.0 10077.9 10626.5 10806.9 11938.6 12013.8 12142.0 12286.9 12427.8 11109.2 11495.9 11516.1 11590.8 11667.6 11374.7 11524.8 11626.4 11662.8 12026.7 11228.3 11248.4 11365.6 11456.3 11643.8 8987.0 8996.3 9282.9 9289.6 9370.2 6948.8 8811.9 8870.5 9311.4 9501.8 05:51:17 INFO - PROCESS | 1666 | -------- Summary: end -------- 05:51:17 INFO - PROCESS | 1666 | 05:51:18 INFO - TEST-INFO | 1666: exit 0 05:51:18 INFO - TEST-OK | dromaeo_css | took 1114278ms 05:51:18 INFO - TEST-START | kraken 05:51:18 INFO - operating with platform_type : mac_ 05:51:18 INFO - Initialising browser for kraken test... 05:51:18 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/tmpzP6XEQ/profile http://localhost:49270/getInfo.html) 05:51:20 INFO - PROCESS | 1672 | __metrics Screen width/height:1600/1200 05:51:20 INFO - PROCESS | 1672 | colorDepth:24 05:51:20 INFO - PROCESS | 1672 | Browser inner width/height: 1024/689 05:51:20 INFO - PROCESS | 1672 | __metrics 05:51:20 INFO - PROCESS | 1672 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:51:20 ERROR - PROCESS | 1672 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 05:51:21 INFO - TEST-INFO | 1672: exit 0 05:51:21 INFO - Browser initialized. 05:51:21 INFO - Running cycle 1/1 for kraken test... 05:51:21 INFO - TEST-INFO | started process 1675 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/tmpzP6XEQ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:51:33 INFO - PROCESS | 1675 | RSS: Main: 243445760 05:51:33 INFO - PROCESS | 1675 | 05:51:35 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 05:51:36 INFO - PROCESS | 1675 | RSS: Main: 289488896 05:51:36 INFO - PROCESS | 1675 | 05:51:38 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 05:51:39 INFO - PROCESS | 1675 | RSS: Main: 299913216 05:51:39 INFO - PROCESS | 1675 | 05:51:42 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 05:51:43 INFO - PROCESS | 1675 | RSS: Main: 285757440 05:51:43 INFO - PROCESS | 1675 | 05:51:45 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 05:51:45 INFO - PROCESS | 1675 | RSS: Main: 290271232 05:51:45 INFO - PROCESS | 1675 | 05:51:47 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:51:48 INFO - PROCESS | 1675 | RSS: Main: 290119680 05:51:48 INFO - PROCESS | 1675 | 05:51:51 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 05:51:51 INFO - PROCESS | 1675 | RSS: Main: 289542144 05:51:51 INFO - PROCESS | 1675 | 05:51:54 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 05:51:55 INFO - PROCESS | 1675 | RSS: Main: 288854016 05:51:55 INFO - PROCESS | 1675 | 05:51:58 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 05:51:58 INFO - PROCESS | 1675 | RSS: Main: 291127296 05:51:58 INFO - PROCESS | 1675 | 05:52:00 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:52:00 INFO - PROCESS | 1675 | RSS: Main: 325152768 05:52:00 INFO - PROCESS | 1675 | 05:52:02 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:52:03 INFO - PROCESS | 1675 | RSS: Main: 324784128 05:52:03 INFO - PROCESS | 1675 | 05:52:05 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:05 INFO - PROCESS | 1675 | RSS: Main: 331694080 05:52:05 INFO - PROCESS | 1675 | 05:52:08 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:09 INFO - PROCESS | 1675 | RSS: Main: 331735040 05:52:09 INFO - PROCESS | 1675 | 05:52:11 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:12 INFO - PROCESS | 1675 | RSS: Main: 332767232 05:52:12 INFO - PROCESS | 1675 | 05:52:14 INFO - PROCESS | 1675 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 05:52:14 INFO - PROCESS | 1675 | RSS: Main: 393318400 05:52:14 INFO - PROCESS | 1675 | 05:52:14 INFO - PROCESS | 1675 | __start_tp_report 05:52:14 INFO - PROCESS | 1675 | _x_x_mozilla_page_load 05:52:14 INFO - PROCESS | 1675 | _x_x_mozilla_page_load_details 05:52:14 INFO - PROCESS | 1675 | |i|pagename|runs| 05:52:14 INFO - PROCESS | 1675 | |0;ai-astar;113;108;111;110;110;111;117;111;110;112 05:52:14 INFO - PROCESS | 1675 | |1;audio-beat-detection;163;152;171;159;120;141;138;120;157;117 05:52:14 INFO - PROCESS | 1675 | |2;audio-dft;186;184;183;184;184;185;183;181;182;179 05:52:14 INFO - PROCESS | 1675 | |3;audio-fft;77;78;84;78;56;58;57;81;77;55 05:52:14 INFO - PROCESS | 1675 | |4;audio-oscillator;96;90;127;81;78;88;116;76;80;115 05:52:14 INFO - PROCESS | 1675 | |5;imaging-gaussian-blur;88;84;90;86;87;85;89;86;89;88 05:52:14 INFO - PROCESS | 1675 | |6;imaging-darkroom;92;94;94;105;148;149;115;93;94;100 05:52:14 INFO - PROCESS | 1675 | |7;imaging-desaturate;87;85;85;86;86;86;92;85;85;129 05:52:14 INFO - PROCESS | 1675 | |8;json-parse-financial;56;56;54;55;55;55;56;64;55;53 05:52:14 INFO - PROCESS | 1675 | |9;json-stringify-tinderbox;63;71;73;74;73;66;67;66;69;67 05:52:14 INFO - PROCESS | 1675 | |10;stanford-crypto-aes;84;84;82;82;83;82;83;82;83;83 05:52:14 INFO - PROCESS | 1675 | |11;stanford-crypto-ccm;146;129;122;119;119;119;115;121;120;119 05:52:14 INFO - PROCESS | 1675 | |12;stanford-crypto-pbkdf2;143;129;139;137;143;178;175;160;136;136 05:52:14 INFO - PROCESS | 1675 | |13;stanford-crypto-sha256-iterative;67;68;64;67;66;68;70;91;95;96 05:52:14 INFO - PROCESS | 1675 | __end_tp_report 05:52:14 INFO - PROCESS | 1675 | __start_cc_report 05:52:14 INFO - PROCESS | 1675 | _x_x_mozilla_cycle_collect,1190 05:52:14 INFO - PROCESS | 1675 | __end_cc_report 05:52:14 INFO - PROCESS | 1675 | __startTimestamp1458046334396__endTimestamp 05:52:14 INFO - PROCESS | 1675 | 05:52:14 INFO - PROCESS | 1675 | ------- Summary: start ------- 05:52:14 INFO - PROCESS | 1675 | Number of tests: 14 05:52:14 INFO - PROCESS | 1675 | 05:52:14 INFO - PROCESS | 1675 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:2.41 (2.2%) stddev-sans-first:2.47 05:52:14 INFO - PROCESS | 1675 | Values: 113.0 108.0 111.0 110.0 110.0 111.0 117.0 111.0 110.0 112.0 05:52:14 INFO - PROCESS | 1675 | 05:52:14 INFO - PROCESS | 1675 | [#1] audio-beat-detection Cycles:10 Average:143.80 Median:154.50 stddev:19.65 (12.7%) stddev-sans-first:19.57 05:52:14 INFO - PROCESS | 1675 | Values: 163.0 152.0 171.0 159.0 120.0 141.0 138.0 120.0 157.0 117.0 05:52:14 INFO - PROCESS | 1675 | 05:52:14 INFO - PROCESS | 1675 | [#2] audio-dft Cycles:10 Average:183.10 Median:184.00 stddev:2.02 (1.1%) stddev-sans-first:1.86 05:52:14 INFO - PROCESS | 1675 | Values: 186.0 184.0 183.0 184.0 184.0 185.0 183.0 181.0 182.0 179.0 05:52:14 INFO - PROCESS | 1675 | 05:52:14 INFO - PROCESS | 1675 | [#3] audio-fft Cycles:10 Average:70.10 Median:77.50 stddev:11.91 (15.4%) stddev-sans-first:12.37 05:52:14 INFO - PROCESS | 1675 | Values: 77.0 78.0 84.0 78.0 56.0 58.0 57.0 81.0 77.0 55.0 05:52:14 INFO - PROCESS | 1675 | 05:52:14 INFO - PROCESS | 1675 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:80.50 stddev:18.29 (22.7%) stddev-sans-first:19.39 05:52:14 INFO - PROCESS | 1675 | Values: 96.0 90.0 127.0 81.0 78.0 88.0 116.0 76.0 80.0 115.0 05:52:14 INFO - PROCESS | 1675 | 05:52:14 INFO - PROCESS | 1675 | [#5] imaging-gaussian-blur Cycles:10 Average:87.20 Median:88.00 stddev:1.93 (2.2%) stddev-sans-first:2.03 05:52:14 INFO - PROCESS | 1675 | Values: 88.0 84.0 90.0 86.0 87.0 85.0 89.0 86.0 89.0 88.0 05:52:14 INFO - PROCESS | 1675 | 05:52:14 INFO - PROCESS | 1675 | [#6] imaging-darkroom Cycles:10 Average:108.40 Median:92.50 stddev:22.29 (24.1%) stddev-sans-first:22.84 05:52:14 INFO - PROCESS | 1675 | Values: 92.0 94.0 94.0 105.0 148.0 149.0 115.0 93.0 94.0 100.0 05:52:14 INFO - PROCESS | 1675 | 05:52:14 INFO - PROCESS | 1675 | [#7] imaging-desaturate Cycles:10 Average:90.60 Median:86.00 stddev:13.66 (15.9%) stddev-sans-first:14.42 05:52:14 INFO - PROCESS | 1675 | Values: 87.0 85.0 85.0 86.0 86.0 86.0 92.0 85.0 85.0 129.0 05:52:14 INFO - PROCESS | 1675 | 05:52:14 INFO - PROCESS | 1675 | [#8] json-parse-financial Cycles:10 Average:55.90 Median:55.50 stddev:3.00 (5.4%) stddev-sans-first:3.18 05:52:14 INFO - PROCESS | 1675 | Values: 56.0 56.0 54.0 55.0 55.0 55.0 56.0 64.0 55.0 53.0 05:52:14 INFO - PROCESS | 1675 | 05:52:14 INFO - PROCESS | 1675 | [#9] json-stringify-tinderbox Cycles:10 Average:68.90 Median:70.00 stddev:3.70 (5.3%) stddev-sans-first:3.24 05:52:14 INFO - PROCESS | 1675 | Values: 63.0 71.0 73.0 74.0 73.0 66.0 67.0 66.0 69.0 67.0 05:52:14 INFO - PROCESS | 1675 | 05:52:14 INFO - PROCESS | 1675 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.00 stddev:0.79 (1.0%) stddev-sans-first:0.71 05:52:14 INFO - PROCESS | 1675 | Values: 84.0 84.0 82.0 82.0 83.0 82.0 83.0 82.0 83.0 83.0 05:52:14 INFO - PROCESS | 1675 | 05:52:14 INFO - PROCESS | 1675 | [#11] stanford-crypto-ccm Cycles:10 Average:122.90 Median:120.50 stddev:8.86 (7.4%) stddev-sans-first:3.77 05:52:14 INFO - PROCESS | 1675 | Values: 146.0 129.0 122.0 119.0 119.0 119.0 115.0 121.0 120.0 119.0 05:52:14 INFO - PROCESS | 1675 | 05:52:14 INFO - PROCESS | 1675 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:147.60 Median:143.00 stddev:17.23 (12.1%) stddev-sans-first:18.20 05:52:14 INFO - PROCESS | 1675 | Values: 143.0 129.0 139.0 137.0 143.0 178.0 175.0 160.0 136.0 136.0 05:52:14 INFO - PROCESS | 1675 | 05:52:14 INFO - PROCESS | 1675 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:75.20 Median:69.00 stddev:13.12 (19.0%) stddev-sans-first:13.58 05:52:14 INFO - PROCESS | 1675 | Values: 67.0 68.0 64.0 67.0 66.0 68.0 70.0 91.0 95.0 96.0 05:52:14 INFO - PROCESS | 1675 | -------- Summary: end -------- 05:52:14 INFO - PROCESS | 1675 | 05:52:15 INFO - TEST-INFO | 1675: exit 0 05:52:15 INFO - TEST-OK | kraken | took 57046ms 05:52:15 INFO - SUITE-END | took 1171s 05:52:15 INFO - Completed test suite (00:19:31) 05:52:15 INFO - javascript benchmark 05:52:15 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3379.6282408935, 3413.214960559072, 3413.573303337083, 3430.091025878142, 3496.37065328241, 5612.887742245163, 5662.886742265152, 5688.687122208277, 5694.202811606373, 5722.513586345155, 5677.545796336293, 5695.544356451484, 5730.942690573093, 5799.217105690731, 5828.912566311508, 5113.437521872591, 5121.769520371592, 5139.897202055975, 5158.9484105158845, 5238.397584277819, 5283.154695248761, 5295.894082118355, 5340.759665815048, 5351.384590772072, 5396.946030539703, 5090.541851233388, 5111.974440127813, 5194.402643695967, 5217.3217481727515, 5226.2944502492055, 5165.018646457161, 5182.455842136559, 5186.974065129688, 5189.481051894818, 5194.92207616886, 5106.897862042775, 5150.969806038807, 5154.12379895415, 5164.1995490699, 5166.844994650129, 5510.393856675762, 5581.330240371181, 5592.412796656333, 5623.606347555673, 5644.8871022579315, 6065.831970971708, 6075.936711075588, 6076.690857474176, 6080.212144473554, 6089.0, 6039.667818269993, 6113.223004260975, 6121.755129794848, 6127.846803829895, 6133.304060594571, 5664.150377443417, 5707.5148612368, 5732.226149469851, 5753.971230143822, 5764.106563482667, 6213.316535181127, 6259.906101408483, 6263.968680156661, 6264.5301602380005, 6265.342139075331, 6015.909761353583, 6137.294211165773, 6154.5076393888385, 6155.815325540241, 6169.2288463942, 6123.326434092335, 6138.6336396323695, 6140.109684095781, 6150.969245153835, 6164.075388691732, 6172.69136543171, 6183.536234782409, 6197.225346831646, 6204.534659900525, 6207.286162091327, 6092.268927728701, 6161.476274516626, 6191.845203869849, 6211.440970312694, 6216.0, 4867.853964381075, 4881.95118048822, 4892.3884514435695, 4895.7062576245535, 4949.282354058641, 4354.608085272277, 4382.2112019836095, 4393.0, 4408.911821763547, 4439.134368798118, 5763.596548241583, 5772.682502462321, 5777.133429985536, 5779.508741756998, 5786.971065144648, 6110.801781737226, 6118.908216376758, 6145.293291271471, 6197.163382943245, 6232.283287422005, 5778.3354914184565, 5808.751118509541, 5821.2141360916585, 5826.980278451254, 5829.300483941955, 5349.946500535023, 5351.331083614548, 5351.438098999627, 5355.30381050461, 5359.892802143935, 6182.845428864224, 6257.4994000480765, 6329.49364050884, 6341.936580634135, 6341.985282354801, 6188.288346840171, 6208.844778880564, 6214.285357183981, 6222.222222222223, 6223.0, 6298.937010629835, 6319.146915166394, 6320.525960553069, 6334.746610135543, 6350.904736428864, 6048.274207095177, 6110.042400473335, 6112.663803490851, 6158.291796443466, 6178.474829639531, 5973.760672742217, 6146.53900957439, 6178.073289006685, 6188.257409110935, 6189.1025801257665, 5937.317208521075, 6061.818145455643, 6065.215230142197, 6078.270607527125, 6140.385961403824, 6000.819975400745, 6047.183630210041, 6085.9695701521205, 6118.449339559461, 6124.448799608057, 5878.941210587839, 5890.352061273171, 5894.351621321565, 5909.468147866713, 5912.46787789101, 5030.99380123984, 5862.296524417097, 6027.156198132177, 6044.304904935812, 6045.335013148462, 5904.911426328523, 5911.852203694942, 5927.110933360031, 5929.881402372014, 5967.46292833647], "unit": "score", "name": "dojo.html", "value": 5672.312323084732}, {"lowerIsBetter": false, "replicates": [504.7249249159208, 579.6869690367205, 580.1558732044875, 632.9493640508758, 638.5944924972642, 31978.840105799467, 39910.60089399105, 39911.401328980086, 39961.400578991335, 39978.0, 43256.35115473263, 43573.91065223371, 43680.34479482802, 43704.56295437045, 43708.78145609275, 9419.152276295115, 9638.0, 9638.469884156404, 9656.179224765903, 9660.227181825472, 9493.430394176337, 9662.613495460173, 9665.130138287554, 9726.0, 9816.460094694788, 8385.538795366252, 9722.173615242713, 9807.0, 9816.067473590034, 9816.411015339067, 9696.030396960317, 9771.804563908752, 9772.804543909082, 9776.0, 9777.755556111082, 9608.567614457366, 9736.172425343855, 9759.316847820655, 9764.170045546138, 9764.658236961743, 34395.65604343949, 41866.1626767466, 42309.0, 42484.93787655303, 42498.78750606258, 3213.4858422652496, 3268.2809781847955, 3269.9182520436943, 3336.1492819331156, 3491.2668339648703, 22644.773552264433, 27267.727322726718, 28860.0, 28897.277568060756, 28943.710562894314, 2712.9321766955786, 2833.8158019728653, 2847.700991395915, 2852.3724780548246, 2935.9559606605703, 405719.0, 407515.99999999703, 407537.0, 408332.0, 408481.9575902131, 67652.3234767646, 67859.0, 72218.63890680514, 72331.63834180901, 72401.99999999895, 76248.0, 76434.61782691051, 76452.61773691207, 76513.0, 76684.61657691788, 15626.0, 15655.765163522556, 17106.914465427843, 17112.144392780312, 17130.571735706457, 11772.764544709058, 11882.28706277626, 11906.46420911061, 13043.217406955613, 13279.93360033213, 16381.594392460773, 17346.392876249272, 21168.682469762967, 21818.0, 21847.672284915738, 9478.336516443782, 9573.18627916621, 9629.264356480146, 9700.757481062888, 9715.757106072404, 795.7095660084028, 840.9705660301983, 959.0313783079001, 1035.9792804144026, 1043.3166276089173, 29811.0, 29903.401931961238, 29921.803127874642, 30402.69597304043, 30576.08271751851, 1083.2687935643567, 1096.4923230557984, 1108.1135091926426, 1167.8365028895962, 1211.854577450694, 14884.851151488347, 14950.925245373703, 14965.551033469013, 15170.393184272727, 15171.089734615958, 633539.0, 638530.0, 643904.0, 644071.0, 644073.0, 61492.69253653793, 61991.0, 62044.37955620476, 62165.378346216865, 62254.0661890072, 1291.0962326371578, 1357.7216670582507, 1382.700261753948, 1488.0848278308763, 1495.53638372105, 26434.735652643998, 29342.55986160252, 29528.11415657534, 29724.405511890072, 29824.701752982193, 46154.76922615366, 50524.231651892005, 51482.742586286826, 52023.47976520186, 52093.21860172025, 402291.0, 406282.0, 406428.0, 406563.0, 406935.0, 28147.296317592223, 33825.49261761125, 34189.82905085458, 34204.0, 34224.486632701024, 41477.476044689734, 42486.36270456007, 42537.36193957031, 42562.78718606387, 43783.0, 34655.480167796995, 35359.0, 35468.82265588759, 36002.8199858999, 36300.81849590735, 35072.64927350694, 35126.64873351234, 35762.0, 35932.10169745777, 37126.628733712314, 36897.26205475822, 37195.25609487849, 37924.62075379211, 38784.8364549064, 38801.0, 26715.599266010635, 30079.0, 31759.52360714545, 32430.513542297358, 32606.51090233601, 24016.39959001039, 24295.392615184763, 24636.13773517918, 24751.133710320053, 24987.50024999526], "unit": "score", "name": "ext.html", "value": 19920.879790372957}, {"lowerIsBetter": false, "replicates": [295.97484213841824, 361.3441603489667, 367.99080022999436, 369.59160128058494, 376.29820384982014, 19071.61856762864, 19991.0, 20718.067686954084, 21174.89412552935, 21213.151473941063, 19563.902180489113, 19866.503337416572, 20704.378868633965, 20722.481937951557, 20750.066247018884, 5215.504527069922, 5350.143976963686, 5406.675599464044, 5416.079266524681, 5417.024935511607, 3197.6322722886816, 4041.4948131483566, 5325.680459172443, 5711.143328500737, 5967.075103358986, 5918.88162236755, 5957.463828255456, 5961.701914904259, 5964.821055368346, 5966.343702192756, 5930.733117009723, 6244.9687751561405, 6251.687415629201, 6390.265119511269, 6432.388923052303, 5678.37537870838, 5680.914786278167, 5682.17608446777, 5693.117566777156, 5697.31632204134, 17530.91234543832, 24450.755492445027, 25344.619830702555, 25384.746152538424, 25421.745782542308, 1831.1942745192073, 1956.4130760771711, 1988.4233572264027, 2039.8164165225053, 2055.660815965379, 9605.51972401384, 9803.411795292306, 10298.17614590831, 12695.238285702888, 14923.806095512442, 1765.8940463572226, 1804.5759246577045, 1805.5666640006305, 1876.249500199931, 1877.633861397028, 104670.47664761628, 109667.45166274198, 110491.34262986062, 110590.34114488288, 110832.4458377711, 11407.030402415887, 11429.942850285695, 11447.027002704863, 11454.828177577343, 11551.249168804, 13759.312034398441, 13841.238731869844, 13880.583582492542, 13885.722285554233, 13901.443942242398, 8508.787280317918, 8679.826403471896, 8695.652173912973, 8784.077671844492, 8799.076097009849, 8894.332925030649, 8905.154010369004, 8923.866142007875, 8984.371094023487, 9020.81958360829, 4415.470143582791, 4501.594856462869, 4508.346289787963, 4551.431071116111, 4576.588107070313, 1743.747156662277, 1822.699254622999, 1835.9632807343778, 1870.9906450467934, 1948.9707654385195, 673.723773252964, 889.4840992224495, 923.1276443760715, 970.0784254957819, 980.6861804222723, 16137.193140342935, 16897.239624216938, 19978.400647980583, 20380.28668996578, 20741.0, 942.0579420579421, 976.2677991506371, 1004.7237009822211, 1042.4370839746603, 1064.9520771565299, 10849.240553161202, 11058.0, 11062.115030797679, 11074.0, 11083.0, 603590.0, 620991.0, 624911.0, 638479.0, 643148.5685143182, 121419.0, 124124.37937810253, 128597.0, 131559.68440315666, 132240.75953544056, 1017.4302390661253, 1053.1101219469535, 1066.3335415365398, 1072.6835583502886, 1073.6617965340893, 17360.652786944444, 17974.0, 18032.2787088515, 18370.265189392274, 18740.156692949124, 50282.497175029246, 53712.1943170845, 55905.88188236294, 56677.0, 56912.71543642255, 77210.61394692991, 77301.0, 78096.60951695433, 79555.20444795478, 80111.0, 7478.915557244278, 7617.124030736536, 7768.339691126092, 8011.759647210593, 8041.8391632168195, 12146.453409596412, 12544.686382840502, 12696.6825829355, 12852.55016074433, 12900.935495322463, 10814.675559733221, 11032.889671103507, 11190.048845848194, 11223.102151827998, 11246.831297530707, 10617.362958222531, 10644.787104258026, 10933.507992140532, 11039.779204416027, 11564.421778910853, 10040.397576145455, 10652.520636571528, 11229.887701122883, 11255.324680519196, 11285.32288062686, 7599.392048636207, 7781.766547003599, 7837.13791482925, 7894.605269736376, 8207.425480216327, 8346.290565302017, 10316.690499285034, 10540.15678745714, 10659.09397701204, 11189.944050279697], "unit": "score", "name": "jquery.html", "value": 9413.208766176276}, {"lowerIsBetter": false, "replicates": [1447.51508244738, 1597.8721702263817, 1637.7297745871936, 1925.451246394777, 2057.9897100514495, 7911.723089691862, 8552.786180345487, 8766.167214114665, 8766.561671916395, 8783.956080219607, 8581.098984606604, 8702.216800487955, 8708.085651006648, 8708.303335733142, 8709.99835018973, 2187.3765976696645, 2411.1801987324393, 2478.095495144268, 2484.31681287646, 2513.183215454975, 2457.7050753909466, 2490.651308816767, 2504.524140413325, 2505.5991041433376, 2505.6116301973225, 2433.245693834917, 2483.4163971466783, 2495.737947515512, 2496.8751562421808, 2499.550080985422, 2189.8467107302495, 2421.624648179535, 2486.8383555069045, 2487.129504673368, 2492.239866840613, 1996.4509759816021, 2464.642626819119, 2504.273760609421, 2506.0101260002198, 2507.9749202507924, 8535.146485351477, 8736.170063843925, 8737.126287371211, 8739.519326437043, 8748.25639820616, 5257.08001099806, 5312.92030619541, 5457.617966742329, 5457.727113644302, 5465.562754979632, 3610.7291953103622, 3677.595464498903, 3738.1776009277914, 3747.3442147624055, 3781.489498917666, 1017.4048181813648, 1021.3055122516686, 1064.3294724323705, 1073.098597178374, 1079.6599071292517, 12001.219920705213, 12003.879961200364, 12007.099467539969, 12015.158938874283, 12019.939900300442, 4939.259111133359, 4966.801327946914, 4975.875603109951, 4993.975030124826, 5066.695998240118, 8343.916560834436, 10158.796824063478, 10195.745106372251, 10198.592056317664, 10224.0, 5504.339479262514, 5527.944720552743, 5536.114221724585, 5537.003339398947, 5550.5282051026115, 3983.521977362735, 4420.734755914591, 4539.750313732777, 4968.30443737877, 4973.328600638867, 3882.776925268531, 3961.900952476211, 3983.7410568312966, 4015.5181378234797, 4021.4369988201674, 1314.8619394963391, 1317.8220940173146, 1318.6241921052454, 1326.0916272353468, 1326.2241588670543, 1103.85098011769, 1127.1996882213557, 1236.3076677060874, 1395.8534353892899, 1400.5588239704462, 8277.58612069394, 8291.005079390512, 8333.374996875258, 8340.249377556049, 8343.415960882801, 513.2122192434595, 529.6927781886496, 532.2442132172324, 543.13641310316, 543.8450041738085, 6298.527610429144, 6305.117283580303, 6317.368263173737, 6338.049292606146, 6367.522435817332, 10324.328918620266, 10675.83986240207, 10769.192310576738, 10825.13398928084, 10837.783244335227, 10280.434576098236, 10555.525001374957, 10579.31234469757, 10624.0, 10744.838827417596, 6986.790396288119, 8366.247037766509, 8439.409241353047, 8492.150784921458, 8498.23515883561, 7764.572948487661, 7965.56189409588, 7985.041794984407, 8004.95997520032, 8009.879851802344, 9352.812943741223, 9603.231741460806, 9617.711468655672, 9685.951570242103, 9764.707058788248, 9854.458004809518, 9980.451075190935, 10091.495425228562, 10210.97890210973, 10228.590856365661, 6266.216722909637, 6722.294159113419, 6815.829604259933, 7371.926280737124, 7580.8483830324185, 8266.628001739817, 8319.126491718282, 8325.916740832514, 8330.458520196167, 8335.624896879775, 7183.497155199086, 7258.600776957318, 7285.744998925013, 7387.852242955219, 7439.442041846992, 6183.196184495987, 7173.390261827803, 7259.346658800522, 7372.41020718352, 7412.444066695128, 7673.693052278069, 7758.379329653501, 7766.339861111643, 7790.571518566307, 7800.1419843816, 6916.377526022682, 7026.156861176692, 7033.085698859116, 7038.40173585251, 7043.36609705129, 6960.025596416404, 7111.82220444493, 7117.644117794193, 7119.893201601876, 7142.178649455379], "unit": "score", "name": "mootools.html", "value": 4841.871589636906}, {"lowerIsBetter": false, "replicates": [328.1451818014074, 329.0703761872709, 336.0406040753647, 336.3508428732545, 339.80631040307037, 5283.0, 6575.243846957601, 6577.34226577342, 6586.934130658692, 6600.207975043001, 5900.262467191601, 6548.0, 6555.77054803082, 6558.540902136852, 6568.934310656892, 4643.558861908114, 4777.307290442884, 4785.760711964405, 4795.0, 4918.58192053675, 4623.930641040387, 4728.952710472903, 4803.855884323476, 4811.278308253755, 4841.3464182335465, 3596.874109406171, 4798.160321943664, 4814.277858321262, 4828.903421931559, 4829.975850120744, 4837.177679794426, 4840.5159484051665, 4843.15244832153, 4853.417589889201, 4855.660103792736, 3980.86066987654, 4072.9185416291803, 4153.231652144333, 4159.854405095837, 4169.020280234173, 5343.706096164709, 5995.381247063268, 6190.226221722285, 6288.276848162428, 6311.779087731908, 4749.907521270093, 5666.801661941812, 5666.979943610148, 5674.290713660793, 5696.601237913348, 6812.761553345609, 6927.272636373159, 6931.677887907557, 6945.062416573748, 6948.826279343007, 4635.745034023127, 4658.976705116486, 4659.58063774262, 4665.790039448233, 4670.486246512881, 7044.36600705939, 7359.521631093961, 7362.8527429451115, 7381.852362952764, 7393.334599885982, 4565.360849481075, 4601.010782681673, 4620.422447194101, 4623.445186577632, 4633.976830115827, 4673.789679464432, 4682.157211701926, 4682.391289132459, 4694.554017368345, 4697.600703940135, 5534.695591742412, 5542.2795036644975, 5543.417941116206, 5549.72251387429, 5552.639603297137, 6682.198136223684, 6956.79129626112, 6994.370506654425, 7002.929970700329, 7006.264342244093, 1448.2107251547932, 1661.46002549172, 1666.658335041338, 1669.8246684098237, 1689.1132155618152, 1095.2771171027084, 1104.8895110488886, 1122.45560902962, 1128.5993472317373, 1129.175701737736, 5581.413951535112, 6396.42432181106, 6451.64515451751, 6603.240627327918, 6632.535722499379, 7060.752873649398, 7188.856222875618, 7219.783406497813, 7236.493445458767, 7244.166920804069, 5421.945780542144, 6637.070810086591, 6650.800475985729, 6675.766348177791, 6687.063811066455, 3774.6225377462033, 3831.1762970961377, 3832.137769001952, 3832.6550610445192, 3840.1743625120735, 7371.078615173104, 7613.885791713129, 7616.9238307617325, 7618.542887426772, 7642.961785191039, 7438.66526006331, 7465.776026719207, 7482.176960534337, 7482.513636613603, 7515.361194298436, 6640.568363056386, 7183.497155199086, 7604.201558836243, 7604.505707129019, 7610.048743907012, 7191.532550384209, 7195.424366050808, 7201.531900426456, 7203.531770434905, 7210.351068403869, 6839.555428897106, 7086.185088714864, 7101.0, 7116.288371163049, 7151.53515021522, 6118.816435506942, 7553.660085296065, 7607.125180604301, 7620.009398778124, 7621.199774023869, 3902.804859756944, 4772.6181905448175, 4786.521347865186, 4791.520847915181, 4797.784099715452, 7171.1394632644415, 7188.856222875409, 7194.532355396883, 7196.640167991684, 7209.71161153548, 6661.866762664817, 6949.965250173716, 6962.582245065312, 6965.407940325129, 6968.442524598121, 6921.688524016532, 6962.094927659372, 6969.4424446045205, 6969.965150174216, 6979.965100174467, 6781.220159681699, 6794.76218332356, 6799.762008329685, 6806.625635589892, 6809.795706128824, 6947.687354068978, 6954.652267386711, 6954.9652251740445, 6960.930390696029, 6966.303369662993, 6546.149000629887, 6779.6271205084195, 6798.150231221098, 6801.761938332134, 6908.654567271717], "unit": "score", "name": "prototype.html", "value": 5096.868234493456}, {"lowerIsBetter": false, "replicates": [696.87804634189, 762.9618519074045, 767.3362541401689, 774.5004472115482, 787.063394560473, 12376.938115309422, 15139.545813625595, 15379.231038448088, 15388.923055384721, 15430.5370838875, 13944.233067181302, 14584.343704533296, 14607.123572585653, 14608.707825843478, 14645.41418343265, 747.5253214208989, 753.9132999705022, 924.3437159616647, 927.5223260021078, 934.4626839567242, 919.4023884475077, 933.9719808405724, 935.6491315756591, 935.6725146198844, 936.8688383626297, 974.790420059687, 993.7913038261973, 994.0, 996.6511720897701, 997.4065431068502, 783.8353945671416, 792.3977776889548, 794.7973266816982, 943.3302355327656, 971.3928794503436, 727.2109760909419, 731.0386841303668, 732.4835990626596, 732.5860888597925, 732.6080546907378, 15321.616959575987, 15351.4626988056, 15352.692946141126, 15364.078155310717, 15371.000884942554, 12611.684707882285, 12862.035347348892, 12909.289989050598, 12968.935155324258, 13061.542846000439, 10069.647562335284, 10225.948870255601, 10307.639232626898, 10516.474176291154, 11066.114710823114, 3577.3560759063357, 3651.8904432867057, 3662.047867554428, 3731.5149030626117, 3750.9624903750887, 85035.57482212549, 86383.13616863814, 86947.0, 87138.0, 87658.0, 9118.088191180961, 9167.495787731605, 9216.769580760401, 9388.718338449857, 9966.900330996743, 20039.499012524804, 20050.899745501472, 20055.197792088155, 20085.899570502053, 20099.095540700702, 7414.740484083031, 7441.516301440389, 7581.924180758232, 7632.160462349138, 7700.191479894643, 4061.4313996039987, 4064.532578753481, 4131.586841315904, 4135.8966025848995, 4211.4525111735275, 3378.391889459921, 3654.543182102237, 3661.7253705972157, 3668.0646435158865, 3672.3573374659327, 570.2216474512261, 646.4698946863621, 663.6548994522917, 664.0603545982477, 669.5547460938421, 578.3943335274561, 584.2579923497135, 602.6956387024525, 612.4671535763825, 619.7768803230833, 7599.734009309758, 7959.920400796033, 8060.193980601893, 8105.351571874236, 8248.8350232995, 564.9180868774005, 574.5489790514426, 607.8389226854798, 619.2599843187438, 620.7796232337546, 3750.718696097804, 3784.8675296364495, 3825.6556909877686, 3858.2862170498547, 4081.3673880548563, 94597.05402945883, 96039.0, 96833.0, 97649.51175244078, 97965.51017244869, 78476.0, 79375.20624793677, 79394.20605793867, 79794.6010269945, 80622.59688701636, 67530.0, 68580.6570967142, 68750.03124546813, 69357.65321173564, 69972.65013675, 6397.424231819158, 7617.27635874591, 7671.347935425328, 7704.576248306173, 7732.536047837148, 37065.0, 49334.0, 49496.50503494919, 49532.0, 50355.74822125866, 69927.0, 70431.29568704247, 70748.64625676839, 70916.0, 71743.28256717366, 9799.314048016855, 9857.0, 10077.949610251902, 10626.468676565986, 10806.891931080589, 11938.64184074479, 12013.81979270329, 12142.0, 12286.938565307117, 12427.813582796085, 11109.222354435113, 11495.942520287344, 11516.136289778467, 11590.768184636428, 11667.59163429276, 11374.715632109264, 11524.842149362128, 11626.360550169484, 11662.766744665229, 12026.699332516757, 11228.326300422, 11248.381339026431, 11365.602203922823, 11456.255343402652, 11643.76712465729, 8987.033633066616, 8996.280297576048, 9282.860757088783, 9289.62841486333, 9370.203532699798, 6948.826279343057, 8811.911880881366, 8870.467771933705, 9311.44131352121, 9501.762455938657], "unit": "score", "name": "yui.html", "value": 6900.517055640487}], "name": "dromaeo_css", "value": 7522.117178347774}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [113.0, 108.0, 111.0, 110.0, 110.0, 111.0, 117.0, 111.0, 110.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [163.0, 152.0, 171.0, 159.0, 120.0, 141.0, 138.0, 120.0, 157.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 143.8}, {"lowerIsBetter": true, "replicates": [186.0, 184.0, 183.0, 184.0, 184.0, 185.0, 183.0, 181.0, 182.0, 179.0], "unit": "score", "name": "audio-dft", "value": 183.1}, {"lowerIsBetter": true, "replicates": [77.0, 78.0, 84.0, 78.0, 56.0, 58.0, 57.0, 81.0, 77.0, 55.0], "unit": "score", "name": "audio-fft", "value": 70.1}, {"lowerIsBetter": true, "replicates": [96.0, 90.0, 127.0, 81.0, 78.0, 88.0, 116.0, 76.0, 80.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 94.7}, {"lowerIsBetter": true, "replicates": [88.0, 84.0, 90.0, 86.0, 87.0, 85.0, 89.0, 86.0, 89.0, 88.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.2}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 94.0, 105.0, 148.0, 149.0, 115.0, 93.0, 94.0, 100.0], "unit": "score", "name": "imaging-darkroom", "value": 108.4}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 85.0, 86.0, 86.0, 86.0, 92.0, 85.0, 85.0, 129.0], "unit": "score", "name": "imaging-desaturate", "value": 90.6}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 54.0, 55.0, 55.0, 55.0, 56.0, 64.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.9}, {"lowerIsBetter": true, "replicates": [63.0, 71.0, 73.0, 74.0, 73.0, 66.0, 67.0, 66.0, 69.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.9}, {"lowerIsBetter": true, "replicates": [84.0, 84.0, 82.0, 82.0, 83.0, 82.0, 83.0, 82.0, 83.0, 83.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.8}, {"lowerIsBetter": true, "replicates": [146.0, 129.0, 122.0, 119.0, 119.0, 119.0, 115.0, 121.0, 120.0, 119.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 122.9}, {"lowerIsBetter": true, "replicates": [143.0, 129.0, 139.0, 137.0, 143.0, 178.0, 175.0, 160.0, 136.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 147.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 64.0, 67.0, 66.0, 68.0, 70.0, 91.0, 95.0, 96.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 75.2}], "name": "kraken", "value": 1442.5000000000002}]} 05:52:15 INFO - Return code: 0 05:52:15 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:52:15 ERROR - # TBPL SUCCESS # 05:52:15 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:52:15 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:52:15 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:52:15 INFO - 2016-03-15 05:52:15.672 screenresolution[1679:9546] starting screenresolution argv=screenresolution get 05:52:15 INFO - 2016-03-15 05:52:15.674 screenresolution[1679:9546] Display 0: 1600x1200x32@60 05:52:15 INFO - 2016-03-15 05:52:15.680 screenresolution[1680:9549] starting screenresolution argv=screenresolution list 05:52:15 INFO - Available Modes on Display 0 05:52:15 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:52:15 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:52:15 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:52:15 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:52:15 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:52:15 INFO - Intel Iris: 05:52:15 INFO - Chipset Model: Intel Iris 05:52:15 INFO - Type: GPU 05:52:15 INFO - Bus: Built-In 05:52:15 INFO - VRAM (Dynamic, Max): 1536 MB 05:52:15 INFO - Vendor: Intel (0x8086) 05:52:15 INFO - Device ID: 0x0a2e 05:52:15 INFO - Revision ID: 0x0009 05:52:15 INFO - Displays: 05:52:15 INFO - Display: 05:52:15 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:52:15 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:52:15 INFO - Display Serial Number: 1600x1200 60 05:52:15 INFO - Main Display: Yes 05:52:15 INFO - Mirror: Off 05:52:15 INFO - Online: Yes 05:52:15 INFO - Rotation: Supported 05:52:15 INFO - Return code: 0 05:52:15 INFO - Running post-action listener: _resource_record_post_action 05:52:15 INFO - Running post-run listener: _resource_record_post_run 05:52:16 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 38856192; Write bytes: 705323008; Read time: 439; Write time: 3232 05:52:16 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 402452992; Write bytes: 404920320; Read time: 30280; Write time: 749 05:52:16 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 37037568; Write bytes: 299395072; Read time: 400; Write time: 2479 05:52:16 INFO - Running post-run listener: _upload_blobber_files 05:52:16 INFO - Blob upload gear active. 05:52:16 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:52:16 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:52:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:52:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:52:17 INFO - (blobuploader) - INFO - Open directory for files ... 05:52:17 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:52:17 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:17 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:18 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:52:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:18 INFO - (blobuploader) - INFO - Done attempting. 05:52:18 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:52:18 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:52:18 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:52:19 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:52:19 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:52:19 INFO - (blobuploader) - INFO - Done attempting. 05:52:19 INFO - (blobuploader) - INFO - Iteration through files over. 05:52:19 INFO - Return code: 0 05:52:19 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:52:19 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:52:19 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2799ef04a68b07bec2c429994478d88a0471d05cd1dea99da0f033f5f0656599253711019e75b1f523a083cd7d9488cff07433ee1aee7cc645e279172f7f379c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b28243df4c0167469e1df4fa3787427f5f4d4be800072898e893a6434436ba94ef9a064f78c5cee0fe0c9313e7d409115ef5da7118ec2df15d3c5020bf05827"} 05:52:19 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:52:19 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:52:19 INFO - Contents: 05:52:19 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2799ef04a68b07bec2c429994478d88a0471d05cd1dea99da0f033f5f0656599253711019e75b1f523a083cd7d9488cff07433ee1aee7cc645e279172f7f379c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b28243df4c0167469e1df4fa3787427f5f4d4be800072898e893a6434436ba94ef9a064f78c5cee0fe0c9313e7d409115ef5da7118ec2df15d3c5020bf05827"} 05:52:19 INFO - Running post-run listener: copy_logs_to_upload_dir 05:52:19 INFO - Copying logs to upload dir... 05:52:19 INFO - mkdir: /builds/slave/test/build/upload/logs 05:52:19 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1266.036658 ========= master_lag: 0.43 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 6 secs) (at 2016-03-15 05:52:19.990149) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-03-15 05:52:19.993220) ========= bash -c 'for file in `ls -1`; do cat $file; done' in dir /builds/slave/test/properties (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', 'for file in `ls -1`; do cat $file; done'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UAQwe0HAqq/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test/properties RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2799ef04a68b07bec2c429994478d88a0471d05cd1dea99da0f033f5f0656599253711019e75b1f523a083cd7d9488cff07433ee1aee7cc645e279172f7f379c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b28243df4c0167469e1df4fa3787427f5f4d4be800072898e893a6434436ba94ef9a064f78c5cee0fe0c9313e7d409115ef5da7118ec2df15d3c5020bf05827"} build_url:https://queue.taskcluster.net/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011401 build_url: 'https://queue.taskcluster.net/v1/task/bQHf6SW2SECNx2JTVt7-0Q/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2799ef04a68b07bec2c429994478d88a0471d05cd1dea99da0f033f5f0656599253711019e75b1f523a083cd7d9488cff07433ee1aee7cc645e279172f7f379c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2b28243df4c0167469e1df4fa3787427f5f4d4be800072898e893a6434436ba94ef9a064f78c5cee0fe0c9313e7d409115ef5da7118ec2df15d3c5020bf05827"}' ========= master_lag: 2.55 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 2 secs) (at 2016-03-15 05:52:22.550480) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 10 secs) (at 2016-03-15 05:52:22.550858) ========= rm -f oauth.txt in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-f', 'oauth.txt'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.UAQwe0HAqq/Render GIT_SHARE_BASE_DIR=/builds/git-shared HG_SHARE_BASE_DIR=/builds/hg-shared HOME=/Users/cltbld IDLEIZER_DISABLE_SHUTDOWN=true LOGNAME=cltbld MOZ_CRASHREPORTER_NO_REPORT=1 MOZ_NO_REMOTE=1 NO_EM_RESTART=1 PAGER=/bin/cat PATH=/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11 PWD=/builds/slave/test RUNNER_CONFIG_CMD=/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg SHELL=/bin/bash SSH_AUTH_SOCK=/private/tmp/com.apple.launchd.btOrvoR2b1/Listeners TMPDIR=/var/folders/8w/zj01xx051wq_syr3ttdymcvh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005075 ========= master_lag: 10.63 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 10 secs) (at 2016-03-15 05:52:33.187037) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 05:52:33.187411) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 05:52:33.250614) ========= ========= Total master_lag: 13.78 =========