builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0147 starttime: 1458794632.66 results: success (0) buildid: 20160323082632 builduid: 5f1f008115fa4c1e91ffa85804ab166d revision: 6202ade0e6d688ffb67932398e56cfc6fa04ceb3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:52.655745) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:52.656227) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:52.656523) ========= 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.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.005623 basedir: '/builds/slave/test' ========= master_lag: 0.20 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:52.861353) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:52.861635) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:52.880433) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:52.880696) ========= 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.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.005930 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:52.928383) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:52.928676) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:52.929045) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:52.929322) ========= 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.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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-23 21:43:52-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.7M=0.001s 2016-03-23 21:43:53 (18.7 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.543129 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:53.490531) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:53.494865) ========= 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.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.026360 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:53.547524) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-23 21:43:53.549899) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 6202ade0e6d688ffb67932398e56cfc6fa04ceb3 --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 6202ade0e6d688ffb67932398e56cfc6fa04ceb3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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-23 21:43:53,628 truncating revision to first 12 chars 2016-03-23 21:43:53,628 Setting DEBUG logging. 2016-03-23 21:43:53,628 attempt 1/10 2016-03-23 21:43:53,628 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/6202ade0e6d6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-23 21:43:55,829 unpacking tar archive at: mozilla-central-6202ade0e6d6/testing/mozharness/ program finished with exit code 0 elapsedTime=2.441042 ========= master_lag: 0.13 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-03-23 21:43:56.125283) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:56.125634) ========= echo 6202ade0e6d688ffb67932398e56cfc6fa04ceb3 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'6202ade0e6d688ffb67932398e56cfc6fa04ceb3'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 6202ade0e6d688ffb67932398e56cfc6fa04ceb3 program finished with exit code 0 elapsedTime=0.006037 script_repo_revision: '6202ade0e6d688ffb67932398e56cfc6fa04ceb3' ========= master_lag: 0.49 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:56.618986) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:56.619393) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-23 21:43:56.635298) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 26 secs) (at 2016-03-23 21:43:56.635581) ========= /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.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 21:43:56 INFO - MultiFileLogger online at 20160323 21:43:56 in /builds/slave/test 21:43:56 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 21:43:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:43:56 INFO - {'append_to_log': False, 21:43:56 INFO - 'base_work_dir': '/builds/slave/test', 21:43:56 INFO - 'blob_upload_branch': 'Firefox', 21:43:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:43:56 INFO - 'branch': 'Firefox', 21:43:56 INFO - 'buildbot_json_path': 'buildprops.json', 21:43:56 INFO - 'config_files': ('talos/mac_config.py',), 21:43:56 INFO - 'default_actions': ('clobber', 21:43:56 INFO - 'read-buildbot-config', 21:43:56 INFO - 'download-and-extract', 21:43:56 INFO - 'populate-webroot', 21:43:56 INFO - 'create-virtualenv', 21:43:56 INFO - 'install', 21:43:56 INFO - 'run-tests'), 21:43:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:43:56 INFO - 'download_minidump_stackwalk': True, 21:43:56 INFO - 'download_symbols': 'ondemand', 21:43:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:43:56 INFO - 'tooltool.py': '/tools/tooltool.py', 21:43:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:43:56 INFO - '/tools/misc-python/virtualenv.py')}, 21:43:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:43:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:43:56 INFO - 'installer_path': 'installer.exe', 21:43:56 INFO - 'log_level': 'info', 21:43:56 INFO - 'log_name': 'talos', 21:43:56 INFO - 'log_to_console': True, 21:43:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:43:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:43:56 INFO - 'opt_config_files': (), 21:43:56 INFO - 'pip_index': False, 21:43:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:43:56 INFO - 'cmd': ('bash', 21:43:56 INFO - '-c', 21:43:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:43:56 INFO - 'enabled': True, 21:43:56 INFO - 'halt_on_failure': False, 21:43:56 INFO - 'name': 'check_screen_resolution'},), 21:43:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:43:56 INFO - 'cmd': ('bash', 21:43:56 INFO - '-c', 21:43:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:43:56 INFO - 'enabled': True, 21:43:56 INFO - 'halt_on_failure': False, 21:43:56 INFO - 'name': 'check_screen_resolution'},), 21:43:56 INFO - 'run_cmd_checks_enabled': True, 21:43:56 INFO - 'sps_profile': False, 21:43:56 INFO - 'sps_profile_interval': 0, 21:43:56 INFO - 'suite': 'dromaeojs', 21:43:56 INFO - 'system_bits': '32', 21:43:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:43:56 INFO - 'title': 't-yosemite-r7-0147', 21:43:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:43:56 INFO - 'use_talos_json': True, 21:43:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:43:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:43:56 INFO - 'work_dir': 'build'} 21:43:56 INFO - ##### 21:43:56 INFO - ##### Running clobber step. 21:43:56 INFO - ##### 21:43:56 INFO - Running pre-action listener: _resource_record_pre_action 21:43:56 INFO - Running main action method: clobber 21:43:56 INFO - rmtree: /builds/slave/test/build 21:43:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:43:58 INFO - Running post-action listener: _resource_record_post_action 21:43:58 INFO - ##### 21:43:58 INFO - ##### Running read-buildbot-config step. 21:43:58 INFO - ##### 21:43:58 INFO - Running pre-action listener: _resource_record_pre_action 21:43:58 INFO - Running main action method: read_buildbot_config 21:43:58 INFO - Using buildbot properties: 21:43:58 INFO - { 21:43:58 INFO - "project": "", 21:43:58 INFO - "product": "firefox", 21:43:58 INFO - "script_repo_revision": "production", 21:43:58 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 21:43:58 INFO - "repository": "", 21:43:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 21:43:58 INFO - "buildid": "20160323082632", 21:43:58 INFO - "pgo_build": "False", 21:43:58 INFO - "basedir": "/builds/slave/test", 21:43:58 INFO - "buildnumber": 181, 21:43:58 INFO - "slavename": "t-yosemite-r7-0147", 21:43:58 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 21:43:58 INFO - "platform": "yosemite_r7", 21:43:58 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 21:43:58 INFO - "branch": "mozilla-central", 21:43:58 INFO - "repo_path": "mozilla-central", 21:43:58 INFO - "revision": "6202ade0e6d688ffb67932398e56cfc6fa04ceb3", 21:43:58 INFO - "stage_platform": "macosx64", 21:43:58 INFO - "builduid": "5f1f008115fa4c1e91ffa85804ab166d", 21:43:58 INFO - "slavebuilddir": "test" 21:43:58 INFO - } 21:43:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 21:43:58 INFO - Running post-action listener: _resource_record_post_action 21:43:58 INFO - ##### 21:43:58 INFO - ##### Running download-and-extract step. 21:43:58 INFO - ##### 21:43:58 INFO - Running pre-action listener: _resource_record_pre_action 21:43:58 INFO - Running main action method: download_and_extract 21:43:58 INFO - mkdir: /builds/slave/test/build/tests 21:43:58 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')]} 21:43:58 INFO - https://queue.taskcluster.net/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 21:43:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 21:43:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 21:43:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/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 21:43:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/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 21:44:14 INFO - Downloaded 1199 bytes. 21:44:14 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 21:44:14 INFO - Using the following test package requirements: 21:44:14 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 21:44:14 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:44:14 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 21:44:14 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:44:14 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 21:44:14 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:44:14 INFO - u'jsshell-mac.zip'], 21:44:14 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:44:14 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 21:44:14 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 21:44:14 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:44:14 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 21:44:14 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:44:14 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 21:44:14 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:44:14 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 21:44:14 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 21:44:14 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 21:44:14 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:44:14 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')]} 21:44:14 INFO - https://queue.taskcluster.net/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:44:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:44:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:44:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/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 21:44:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/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 21:44:30 INFO - Downloaded 17919443 bytes. 21:44:30 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'] 21:44:30 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 21:44:33 INFO - Return code: 0 21:44:33 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 21:44:33 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')]} 21:44:33 INFO - https://queue.taskcluster.net/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:44:33 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:44:33 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 21:44:33 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/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 21:44:33 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/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 21:44:45 INFO - Downloaded 17919443 bytes. 21:44:45 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'] 21:44:45 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 21:44:48 INFO - Return code: 0 21:44:48 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')]} 21:44:48 INFO - https://queue.taskcluster.net/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:44:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:44:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 21:44:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/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 21:44:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/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 21:45:00 INFO - Downloaded 10846780 bytes. 21:45:00 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'] 21:45:00 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 21:45:00 INFO - Return code: 0 21:45: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')]} 21:45:00 INFO - https://queue.taskcluster.net/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:45:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:45:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:45:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 21:45:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/YOXdP892Q3GAIVqa7mFBBg/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 21:45:31 INFO - Downloaded 111271370 bytes. 21:45:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:45:31 INFO - mkdir: /builds/slave/test/properties 21:45:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:45:31 INFO - Writing to file /builds/slave/test/properties/build_url 21:45:31 INFO - Contents: 21:45:31 INFO - build_url:https://queue.taskcluster.net/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 21:45:33 INFO - Running post-action listener: _resource_record_post_action 21:45:33 INFO - Running post-action listener: set_extra_try_arguments 21:45:33 INFO - ##### 21:45:33 INFO - ##### Running populate-webroot step. 21:45:33 INFO - ##### 21:45:33 INFO - Running pre-action listener: _resource_record_pre_action 21:45:33 INFO - Running main action method: populate_webroot 21:45:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:45:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:45:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:45:33 INFO - '--tppagecycles', 21:45:33 INFO - '7'], 21:45:33 INFO - 'tests': ['tsvgm']}}, 21:45:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:45:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:45:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:45:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 21:45:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:45:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 21:45:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:45:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:33 INFO - 'talos_options': ['--e10s'], 21:45:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:45:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:33 INFO - 'tests': ['damp', 'tps']}, 21:45:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:33 INFO - 'talos_options': ['--e10s'], 21:45:33 INFO - 'tests': ['damp', 'tps']}, 21:45:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:45:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:45:33 INFO - 'other': {'tests': ['a11yr', 21:45:33 INFO - 'ts_paint', 21:45:33 INFO - 'tpaint', 21:45:33 INFO - 'sessionrestore', 21:45:33 INFO - 'sessionrestore_no_auto_restore', 21:45:33 INFO - 'tabpaint']}, 21:45:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:45:33 INFO - 'tests': ['a11yr', 21:45:33 INFO - 'ts_paint', 21:45:33 INFO - 'tpaint', 21:45:33 INFO - 'sessionrestore', 21:45:33 INFO - 'sessionrestore_no_auto_restore', 21:45:33 INFO - 'tabpaint']}, 21:45:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:45:33 INFO - 'tests': ['a11yr', 21:45:33 INFO - 'ts_paint', 21:45:33 INFO - 'tpaint', 21:45:33 INFO - 'sessionrestore', 21:45:33 INFO - 'sessionrestore_no_auto_restore', 21:45:33 INFO - 'tabpaint']}, 21:45:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:45:33 INFO - 'tests': ['a11yr', 21:45:33 INFO - 'ts_paint', 21:45:33 INFO - 'tpaint', 21:45:33 INFO - 'sessionrestore', 21:45:33 INFO - 'sessionrestore_no_auto_restore', 21:45:33 INFO - 'tabpaint']}, 21:45:33 INFO - 'other_l64': {'tests': ['a11yr', 21:45:33 INFO - 'ts_paint', 21:45:33 INFO - 'tpaint', 21:45:33 INFO - 'sessionrestore', 21:45:33 INFO - 'sessionrestore_no_auto_restore', 21:45:33 INFO - 'tabpaint']}, 21:45:33 INFO - 'other_nol64': {'tests': ['a11yr', 21:45:33 INFO - 'ts_paint', 21:45:33 INFO - 'tpaint', 21:45:33 INFO - 'sessionrestore', 21:45:33 INFO - 'sessionrestore_no_auto_restore', 21:45:33 INFO - 'tabpaint']}, 21:45:33 INFO - 'svgr': {'tests': ['tsvgx', 21:45:33 INFO - 'tsvgr_opacity', 21:45:33 INFO - 'tart', 21:45:33 INFO - 'tscrollx', 21:45:33 INFO - 'cart']}, 21:45:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:45:33 INFO - 'tests': ['tsvgx', 21:45:33 INFO - 'tsvgr_opacity', 21:45:33 INFO - 'tart', 21:45:33 INFO - 'tscrollx', 21:45:33 INFO - 'cart']}, 21:45:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:33 INFO - 'tests': ['tp5o']}, 21:45:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:33 INFO - 'talos_options': ['--e10s'], 21:45:33 INFO - 'tests': ['tp5o']}, 21:45:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:33 INFO - 'talos_options': ['--xperf_path', 21:45:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:45:33 INFO - 'tests': ['tp5n']}, 21:45:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:45:33 INFO - 'talos_options': ['--e10s', 21:45:33 INFO - '--xperf_path', 21:45:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:45:33 INFO - 'tests': ['tp5n']}}, 21:45:33 INFO - 'talos.zip': {'path': '', 21:45:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:45:33 INFO - Running post-action listener: _resource_record_post_action 21:45:33 INFO - ##### 21:45:33 INFO - ##### Running create-virtualenv step. 21:45:33 INFO - ##### 21:45:33 INFO - Running pre-action listener: _resource_record_pre_action 21:45:33 INFO - Running main action method: create_virtualenv 21:45:33 INFO - Creating virtualenv /builds/slave/test/build/venv 21:45:33 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 21:45:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:45:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:45:33 INFO - Using real prefix '/tools/python27' 21:45:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:45:33 INFO - Installing distribute.............................................................................................................................................................................................done. 21:45:36 INFO - Installing pip.................done. 21:45:36 INFO - Return code: 0 21:45:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:45: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')]} 21:45:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45: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')]} 21:45:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45: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 0x10248da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10249d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab33589020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232ce00>, '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 0x102155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102327b20>, '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.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 21:45: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 21:45: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 21:45:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2aO45RPHJ/Render', 21:45:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:45:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:45:36 INFO - 'HOME': '/Users/cltbld', 21:45:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:45:36 INFO - 'LOGNAME': 'cltbld', 21:45:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:36 INFO - 'MOZ_NO_REMOTE': '1', 21:45:36 INFO - 'NO_EM_RESTART': '1', 21:45:36 INFO - 'PAGER': '/bin/cat', 21:45:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:45:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:36 INFO - 'PWD': '/builds/slave/test', 21:45:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:45:36 INFO - 'SHELL': '/bin/bash', 21:45:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfpk5tlVtn/Listeners', 21:45:36 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 21:45:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:45:36 INFO - 'USER': 'cltbld', 21:45:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:45:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:45:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:36 INFO - 'XPC_FLAGS': '0x0', 21:45:36 INFO - 'XPC_SERVICE_NAME': '0', 21:45:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:37 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 21:45:37 INFO - Cleaning up... 21:45:37 INFO - Return code: 0 21:45:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:45:37 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')]} 21:45:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:37 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')]} 21:45:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:37 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 0x10248da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10249d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab33589020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232ce00>, '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 0x102155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102327b20>, '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.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 21:45:37 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 21:45:37 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 21:45:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2aO45RPHJ/Render', 21:45:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:45:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:45:37 INFO - 'HOME': '/Users/cltbld', 21:45:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:45:37 INFO - 'LOGNAME': 'cltbld', 21:45:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:37 INFO - 'MOZ_NO_REMOTE': '1', 21:45:37 INFO - 'NO_EM_RESTART': '1', 21:45:37 INFO - 'PAGER': '/bin/cat', 21:45:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:45:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:37 INFO - 'PWD': '/builds/slave/test', 21:45:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:45:37 INFO - 'SHELL': '/bin/bash', 21:45:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfpk5tlVtn/Listeners', 21:45:37 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 21:45:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:45:37 INFO - 'USER': 'cltbld', 21:45:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:45:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:45:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:37 INFO - 'XPC_FLAGS': '0x0', 21:45:37 INFO - 'XPC_SERVICE_NAME': '0', 21:45:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:45:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:37 INFO - Downloading/unpacking psutil>=0.7.1 21:45: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 21:45: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 21:45: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 21:45: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 21:45: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 21:45: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 21:45:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:45:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:45:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:45:41 INFO - Installing collected packages: psutil 21:45:41 INFO - Running setup.py install for psutil 21:45:41 INFO - building 'psutil._psutil_osx' extension 21:45: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 21:45: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 21:45: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 21:45: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 21:45:42 INFO - building 'psutil._psutil_posix' extension 21:45:42 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 21:45:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:45:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:45:42 INFO - ^ 21:45:42 INFO - 1 warning generated. 21:45:42 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 21:45:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:45:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:45:42 INFO - Successfully installed psutil 21:45:42 INFO - Cleaning up... 21:45:42 INFO - Return code: 0 21:45:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:45: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')]} 21:45:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45: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')]} 21:45:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45: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 0x10248da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10249d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab33589020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232ce00>, '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 0x102155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102327b20>, '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.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 21:45: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 21:45: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 21:45:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2aO45RPHJ/Render', 21:45:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:45:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:45:42 INFO - 'HOME': '/Users/cltbld', 21:45:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:45:42 INFO - 'LOGNAME': 'cltbld', 21:45:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:42 INFO - 'MOZ_NO_REMOTE': '1', 21:45:42 INFO - 'NO_EM_RESTART': '1', 21:45:42 INFO - 'PAGER': '/bin/cat', 21:45:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:45:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:42 INFO - 'PWD': '/builds/slave/test', 21:45:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:45:42 INFO - 'SHELL': '/bin/bash', 21:45:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfpk5tlVtn/Listeners', 21:45:42 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 21:45:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:45:42 INFO - 'USER': 'cltbld', 21:45:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:45:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:45:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:42 INFO - 'XPC_FLAGS': '0x0', 21:45:42 INFO - 'XPC_SERVICE_NAME': '0', 21:45:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:45:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:45: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 21:45: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 21:45: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 21:45: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 21:45: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 21:45: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 21:45:46 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:45:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:45:46 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:45:46 INFO - Installing collected packages: mozsystemmonitor 21:45:46 INFO - Running setup.py install for mozsystemmonitor 21:45:46 INFO - Successfully installed mozsystemmonitor 21:45:46 INFO - Cleaning up... 21:45:46 INFO - Return code: 0 21:45:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:45:46 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')]} 21:45:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:46 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')]} 21:45:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:46 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 0x10248da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10249d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab33589020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232ce00>, '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 0x102155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102327b20>, '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.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 21:45:46 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 21:45:46 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 21:45:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2aO45RPHJ/Render', 21:45:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:45:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:45:46 INFO - 'HOME': '/Users/cltbld', 21:45:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:45:46 INFO - 'LOGNAME': 'cltbld', 21:45:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:46 INFO - 'MOZ_NO_REMOTE': '1', 21:45:46 INFO - 'NO_EM_RESTART': '1', 21:45:46 INFO - 'PAGER': '/bin/cat', 21:45:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:45:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:46 INFO - 'PWD': '/builds/slave/test', 21:45:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:45:46 INFO - 'SHELL': '/bin/bash', 21:45:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfpk5tlVtn/Listeners', 21:45:46 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 21:45:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:45:46 INFO - 'USER': 'cltbld', 21:45:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:45:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:45:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:46 INFO - 'XPC_FLAGS': '0x0', 21:45:46 INFO - 'XPC_SERVICE_NAME': '0', 21:45:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:45:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:47 INFO - Downloading/unpacking blobuploader==1.2.4 21:45: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 21:45: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 21:45: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 21:45: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 21:45: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 21:45: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 21:45:50 INFO - Downloading blobuploader-1.2.4.tar.gz 21:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:45:51 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:45:51 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 21:45:51 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 21:45:51 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 21:45:51 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 21:45:51 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 21:45:51 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 21:45:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:45:52 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:45:52 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 21:45:52 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 21:45:52 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 21:45:52 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 21:45:52 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 21:45:52 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 21:45:52 INFO - Downloading docopt-0.6.1.tar.gz 21:45:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:45:52 INFO - Installing collected packages: blobuploader, requests, docopt 21:45:52 INFO - Running setup.py install for blobuploader 21:45:52 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:45:52 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:45:52 INFO - Running setup.py install for requests 21:45:53 INFO - Running setup.py install for docopt 21:45:53 INFO - Successfully installed blobuploader requests docopt 21:45:53 INFO - Cleaning up... 21:45:53 INFO - Return code: 0 21:45:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:45:53 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')]} 21:45:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:53 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')]} 21:45:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:53 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 0x10248da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10249d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab33589020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232ce00>, '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 0x102155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102327b20>, '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.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 21:45:53 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 21:45:53 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 21:45:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2aO45RPHJ/Render', 21:45:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:45:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:45:53 INFO - 'HOME': '/Users/cltbld', 21:45:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:45:53 INFO - 'LOGNAME': 'cltbld', 21:45:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:53 INFO - 'MOZ_NO_REMOTE': '1', 21:45:53 INFO - 'NO_EM_RESTART': '1', 21:45:53 INFO - 'PAGER': '/bin/cat', 21:45:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:45:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:53 INFO - 'PWD': '/builds/slave/test', 21:45:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:45:53 INFO - 'SHELL': '/bin/bash', 21:45:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfpk5tlVtn/Listeners', 21:45:53 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 21:45:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:45:53 INFO - 'USER': 'cltbld', 21:45:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:45:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:45:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:53 INFO - 'XPC_FLAGS': '0x0', 21:45:53 INFO - 'XPC_SERVICE_NAME': '0', 21:45:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:45:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:45:54 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-QrJOZ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:45:54 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-SnOVT7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:45:54 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-Kqjo5F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:45:54 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-WDZYn5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:45:54 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-KJ57_q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:45:54 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-KblYlS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:45:54 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-vGnIMI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:45:54 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-5UMux6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:45:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:45:54 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-mfL3A9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:45:55 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-KdTjzu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:45:55 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-75oI6u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:45:55 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-Ta7ttm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:45:55 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-tA00tO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:45:55 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-0MHy_s-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:45:55 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-rprq57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:45:55 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-3DczfB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:45:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:45:55 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-GCpE63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:45:55 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:45:55 INFO - Running setup.py install for manifestparser 21:45:56 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:45:56 INFO - Running setup.py install for mozcrash 21:45:56 INFO - Running setup.py install for mozdebug 21:45:56 INFO - Running setup.py install for mozdevice 21:45:56 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:45:56 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:45:56 INFO - Running setup.py install for mozfile 21:45:56 INFO - Running setup.py install for mozhttpd 21:45:56 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:45:56 INFO - Running setup.py install for mozinfo 21:45:56 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:45:56 INFO - Running setup.py install for mozInstall 21:45:57 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:45:57 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:45:57 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:45:57 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:45:57 INFO - Running setup.py install for mozleak 21:45:57 INFO - Running setup.py install for mozlog 21:45:57 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:45:57 INFO - Running setup.py install for moznetwork 21:45:57 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:45:57 INFO - Running setup.py install for mozprocess 21:45:57 INFO - Running setup.py install for mozprofile 21:45:57 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:45:57 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:45:57 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:45:57 INFO - Running setup.py install for mozrunner 21:45:57 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:45:57 INFO - Running setup.py install for mozscreenshot 21:45:58 INFO - Running setup.py install for moztest 21:45:58 INFO - Running setup.py install for mozversion 21:45:58 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:45:58 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:45:58 INFO - Cleaning up... 21:45:58 INFO - Return code: 0 21:45:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:45:58 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')]} 21:45:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:45:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:58 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')]} 21:45:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:45:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:45:58 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 0x10248da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10249d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab33589020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232ce00>, '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 0x102155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102327b20>, '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.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 21:45:58 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 21:45:58 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 21:45:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2aO45RPHJ/Render', 21:45:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:45:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:45:58 INFO - 'HOME': '/Users/cltbld', 21:45:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:45:58 INFO - 'LOGNAME': 'cltbld', 21:45:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:45:58 INFO - 'MOZ_NO_REMOTE': '1', 21:45:58 INFO - 'NO_EM_RESTART': '1', 21:45:58 INFO - 'PAGER': '/bin/cat', 21:45:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:45:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:45:58 INFO - 'PWD': '/builds/slave/test', 21:45:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:45:58 INFO - 'SHELL': '/bin/bash', 21:45:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfpk5tlVtn/Listeners', 21:45:58 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 21:45:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:45:58 INFO - 'USER': 'cltbld', 21:45:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:45:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:45:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:45:58 INFO - 'XPC_FLAGS': '0x0', 21:45:58 INFO - 'XPC_SERVICE_NAME': '0', 21:45:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:45:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:45:58 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-VFv9Tk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:45:58 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)) 21:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:45:58 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-VMvO0K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:45:58 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)) 21:45:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:45:58 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-U7wFrE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:45:59 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)) 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:45:59 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-NocMkd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:45:59 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)) 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:45:59 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-Xvt8Du-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:45:59 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)) 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:45:59 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-zL89Jc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:45:59 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)) 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:45:59 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-OPay8G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:45:59 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)) 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:45:59 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-sPz1NB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:45:59 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)) 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:45:59 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-5vj3jH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:45:59 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)) 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:45:59 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-l_XDWJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:45:59 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)) 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:45:59 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-yIR_iS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:45:59 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)) 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:45:59 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-GtolEj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:45:59 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)) 21:45:59 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:45:59 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-f6qapC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:46:00 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)) 21:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:46:00 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-tNkIjV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:46:00 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)) 21:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:00 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-5nlB0S-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:46:00 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)) 21:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:46:00 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-2VKFOt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:46:00 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)) 21:46:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:46:00 INFO - Running setup.py (path:/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/pip-Tc6Bcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:46:00 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)) 21:46:00 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)) 21:46:00 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)) 21:46:00 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)) 21:46:00 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)) 21:46:00 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)) 21:46:00 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46:05 INFO - Downloading blessings-1.6.tar.gz 21:46:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:46:05 INFO - Installing collected packages: blessings 21:46:05 INFO - Running setup.py install for blessings 21:46:05 INFO - Successfully installed blessings 21:46:05 INFO - Cleaning up... 21:46:05 INFO - Return code: 0 21:46:05 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:46:05 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:46:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:46:06 INFO - Reading from file tmpfile_stdout 21:46:06 INFO - Current package versions: 21:46:06 INFO - blessings == 1.6 21:46:06 INFO - blobuploader == 1.2.4 21:46:06 INFO - docopt == 0.6.1 21:46:06 INFO - manifestparser == 1.1 21:46:06 INFO - mozInstall == 1.12 21:46:06 INFO - mozcrash == 0.17 21:46:06 INFO - mozdebug == 0.1 21:46:06 INFO - mozdevice == 0.48 21:46:06 INFO - mozfile == 1.2 21:46:06 INFO - mozhttpd == 0.7 21:46:06 INFO - mozinfo == 0.9 21:46:06 INFO - mozleak == 0.1 21:46:06 INFO - mozlog == 3.1 21:46:06 INFO - moznetwork == 0.27 21:46:06 INFO - mozprocess == 0.22 21:46:06 INFO - mozprofile == 0.28 21:46:06 INFO - mozrunner == 6.11 21:46:06 INFO - mozscreenshot == 0.1 21:46:06 INFO - mozsystemmonitor == 0.0 21:46:06 INFO - moztest == 0.7 21:46:06 INFO - mozversion == 1.4 21:46:06 INFO - psutil == 3.1.1 21:46:06 INFO - requests == 1.2.3 21:46:06 INFO - wsgiref == 0.1.2 21:46:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:46:06 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')]} 21:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:06 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')]} 21:46:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:06 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 0x10248da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10249d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab33589020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232ce00>, '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 0x102155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102327b20>, '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.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 21:46:06 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 21:46:06 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 21:46:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2aO45RPHJ/Render', 21:46:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:06 INFO - 'HOME': '/Users/cltbld', 21:46:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:06 INFO - 'LOGNAME': 'cltbld', 21:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:06 INFO - 'MOZ_NO_REMOTE': '1', 21:46:06 INFO - 'NO_EM_RESTART': '1', 21:46:06 INFO - 'PAGER': '/bin/cat', 21:46:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:06 INFO - 'PWD': '/builds/slave/test', 21:46:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:06 INFO - 'SHELL': '/bin/bash', 21:46:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfpk5tlVtn/Listeners', 21:46:06 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 21:46:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:06 INFO - 'USER': 'cltbld', 21:46:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:06 INFO - 'XPC_FLAGS': '0x0', 21:46:06 INFO - 'XPC_SERVICE_NAME': '0', 21:46:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:06 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)) 21:46:06 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)) 21:46:06 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)) 21:46:06 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)) 21:46:06 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)) 21:46:06 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)) 21:46:06 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)) 21:46:06 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)) 21:46:06 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)) 21:46:06 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)) 21:46:06 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)) 21:46:06 INFO - Cleaning up... 21:46:06 INFO - Return code: 0 21:46:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 21:46:06 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')]} 21:46:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:06 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')]} 21:46:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:06 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 0x10248da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10249d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab33589020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232ce00>, '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 0x102155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102327b20>, '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.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 21:46:06 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 21:46:06 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 21:46:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2aO45RPHJ/Render', 21:46:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:06 INFO - 'HOME': '/Users/cltbld', 21:46:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:06 INFO - 'LOGNAME': 'cltbld', 21:46:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:06 INFO - 'MOZ_NO_REMOTE': '1', 21:46:06 INFO - 'NO_EM_RESTART': '1', 21:46:06 INFO - 'PAGER': '/bin/cat', 21:46:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:06 INFO - 'PWD': '/builds/slave/test', 21:46:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:06 INFO - 'SHELL': '/bin/bash', 21:46:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfpk5tlVtn/Listeners', 21:46:06 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 21:46:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:06 INFO - 'USER': 'cltbld', 21:46:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:06 INFO - 'XPC_FLAGS': '0x0', 21:46:06 INFO - 'XPC_SERVICE_NAME': '0', 21:46:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:06 INFO - Downloading/unpacking jsonschema 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46: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 21:46:09 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 21:46:09 INFO - Downloading/unpacking functools32 (from jsonschema) 21:46:09 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 21:46:09 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 21:46:09 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 21:46:09 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 21:46:09 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 21:46:09 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 21:46:09 INFO - Downloading functools32-3.2.3-2.tar.gz 21:46:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 21:46:09 INFO - warning: no files found matching '*.txt' 21:46:09 INFO - no previously-included directories found matching 'build' 21:46:09 INFO - no previously-included directories found matching 'dist' 21:46:09 INFO - no previously-included directories found matching '.git*' 21:46:09 INFO - Installing collected packages: jsonschema, functools32 21:46:09 INFO - Running setup.py install for functools32 21:46:09 INFO - warning: no files found matching '*.txt' 21:46:09 INFO - no previously-included directories found matching 'build' 21:46:09 INFO - no previously-included directories found matching 'dist' 21:46:09 INFO - no previously-included directories found matching '.git*' 21:46:09 INFO - Successfully installed jsonschema functools32 21:46:09 INFO - Cleaning up... 21:46:09 INFO - Return code: 0 21:46:09 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 21:46:09 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')]} 21:46:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:46:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:09 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')]} 21:46:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:46:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:46:09 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 0x10248da30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10249d420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fab33589020>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10232ce00>, '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 0x102155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102327b20>, '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.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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 21:46:09 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 21:46:09 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 21:46:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2aO45RPHJ/Render', 21:46:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:09 INFO - 'HOME': '/Users/cltbld', 21:46:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:09 INFO - 'LOGNAME': 'cltbld', 21:46:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:09 INFO - 'MOZ_NO_REMOTE': '1', 21:46:09 INFO - 'NO_EM_RESTART': '1', 21:46:09 INFO - 'PAGER': '/bin/cat', 21:46:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:09 INFO - 'PWD': '/builds/slave/test', 21:46:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:09 INFO - 'SHELL': '/bin/bash', 21:46:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfpk5tlVtn/Listeners', 21:46:09 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 21:46:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:09 INFO - 'USER': 'cltbld', 21:46:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:09 INFO - 'XPC_FLAGS': '0x0', 21:46:09 INFO - 'XPC_SERVICE_NAME': '0', 21:46:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:46:10 INFO - Downloading/unpacking flake8 21:46:10 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 21:46:10 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 21:46:10 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 21:46:10 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 21:46:10 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 21:46:10 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 21:46:13 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 21:46:13 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 21:46:13 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 21:46:13 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 21:46:13 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 21:46:13 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 21:46:13 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 21:46:13 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 21:46:13 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 21:46:13 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 21:46:13 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 21:46:13 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 21:46:13 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 21:46:13 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 21:46:13 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 21:46:13 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 21:46:14 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 21:46:14 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 21:46:14 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 21:46:14 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 21:46:14 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 21:46:14 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 21:46:14 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 21:46:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 21:46:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:46:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:46:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:46:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:46:14 INFO - no previously-included directories found matching 'docs/_build' 21:46:14 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 21:46:14 INFO - Running setup.py install for pep8 21:46:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 21:46:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 21:46:14 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 21:46:14 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 21:46:14 INFO - no previously-included directories found matching 'docs/_build' 21:46:14 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 21:46:14 INFO - Successfully installed flake8 mccabe pyflakes pep8 21:46:14 INFO - Cleaning up... 21:46:14 INFO - Return code: 0 21:46:14 INFO - Running post-action listener: _resource_record_post_action 21:46:14 INFO - Running post-action listener: _start_resource_monitoring 21:46:14 INFO - Starting resource monitoring. 21:46:14 INFO - ##### 21:46:14 INFO - ##### Running install step. 21:46:14 INFO - ##### 21:46:14 INFO - Running pre-action listener: _resource_record_pre_action 21:46:14 INFO - Running main action method: install 21:46:14 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:46:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:46:15 INFO - Reading from file tmpfile_stdout 21:46:15 INFO - Detecting whether we're running mozinstall >=1.0... 21:46:15 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:46:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:46:15 INFO - Reading from file tmpfile_stdout 21:46:15 INFO - Output received: 21:46:15 INFO - Usage: mozinstall [options] installer 21:46:15 INFO - Options: 21:46:15 INFO - -h, --help show this help message and exit 21:46:15 INFO - -d DEST, --destination=DEST 21:46:15 INFO - Directory to install application into. [default: 21:46:15 INFO - "/builds/slave/test"] 21:46:15 INFO - --app=APP Application being installed. [default: firefox] 21:46:15 INFO - mkdir: /builds/slave/test/build/application 21:46:15 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'] 21:46:15 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 21:46:49 INFO - Reading from file tmpfile_stdout 21:46:49 INFO - Output received: 21:46:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:46:49 INFO - Running post-action listener: _resource_record_post_action 21:46:49 INFO - ##### 21:46:49 INFO - ##### Running run-tests step. 21:46:49 INFO - ##### 21:46:49 INFO - Running pre-action listener: _resource_record_pre_action 21:46:49 INFO - Running main action method: run_tests 21:46:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:46:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:46:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:46:49 INFO - 2016-03-23 21:46:49.206 screenresolution[1650:7838] starting screenresolution argv=screenresolution get 21:46:49 INFO - 2016-03-23 21:46:49.209 screenresolution[1650:7838] Display 0: 1600x1200x32@60 21:46:49 INFO - 2016-03-23 21:46:49.214 screenresolution[1651:7840] starting screenresolution argv=screenresolution list 21:46:49 INFO - Available Modes on Display 0 21:46:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:46:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:46:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:46:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:46:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:46:49 INFO - Intel Iris: 21:46:49 INFO - Chipset Model: Intel Iris 21:46:49 INFO - Type: GPU 21:46:49 INFO - Bus: Built-In 21:46:49 INFO - VRAM (Dynamic, Max): 1536 MB 21:46:49 INFO - Vendor: Intel (0x8086) 21:46:49 INFO - Device ID: 0x0a2e 21:46:49 INFO - Revision ID: 0x0009 21:46:49 INFO - Displays: 21:46:49 INFO - Display: 21:46:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:46:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:46:49 INFO - Display Serial Number: 1600x1200 60 21:46:49 INFO - Main Display: Yes 21:46:49 INFO - Mirror: Off 21:46:49 INFO - Online: Yes 21:46:49 INFO - Rotation: Supported 21:46:49 INFO - Return code: 0 21:46:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:46:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:46:49 INFO - Python 2.7.3 21:46:49 INFO - Return code: 0 21:46:49 INFO - grabbing minidump binary from tooltool 21:46: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')]} 21:46:49 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 0x10232ce00>, '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 0x102155db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x102327b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:46:49 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 21:46:49 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 21:46:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:46:49 INFO - Return code: 0 21:46:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:46:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:46:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:46:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:46:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:46:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 21:46:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 21:46:50 INFO - Return code: 0 21:46:50 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0147', '--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 21:46:50 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0147 --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 21:46:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.L2aO45RPHJ/Render', 21:46:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:46:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:46:50 INFO - 'HOME': '/Users/cltbld', 21:46:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:46:50 INFO - 'LOGNAME': 'cltbld', 21:46:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:46:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:46:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:46:50 INFO - 'MOZ_NO_REMOTE': '1', 21:46:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:46:50 INFO - 'NO_EM_RESTART': '1', 21:46:50 INFO - 'PAGER': '/bin/cat', 21:46:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:46:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:46:50 INFO - 'PWD': '/builds/slave/test', 21:46:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:46:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:46:50 INFO - 'SHELL': '/bin/bash', 21:46:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Sfpk5tlVtn/Listeners', 21:46:50 INFO - 'TMPDIR': '/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/', 21:46:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:46:50 INFO - 'USER': 'cltbld', 21:46:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:46:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:46:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:46:50 INFO - 'XPC_FLAGS': '0x0', 21:46:50 INFO - 'XPC_SERVICE_NAME': '0', 21:46:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 21:46:50 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0147', '--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 21:46:50 INFO - mozversion application_buildid: 20160323082632 21:46:50 INFO - mozversion application_changeset: 6202ade0e6d688ffb67932398e56cfc6fa04ceb3 21:46:50 INFO - mozversion application_display_name: Nightly 21:46:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:46:50 INFO - mozversion application_name: Firefox 21:46:50 INFO - mozversion application_remotingname: firefox 21:46:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 21:46:50 INFO - mozversion application_vendor: Mozilla 21:46:50 INFO - mozversion application_version: 48.0a1 21:46:50 INFO - mozversion platform_buildid: 20160323082632 21:46:50 INFO - mozversion platform_changeset: 6202ade0e6d688ffb67932398e56cfc6fa04ceb3 21:46:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 21:46:50 INFO - mozversion platform_version: 48.0a1 21:46:50 INFO - using testdate: 1458794810 21:46:50 INFO - actual date: 1458794810 21:46:50 INFO - starting webserver on 'localhost:49276' 21:46:50 INFO - SUITE-START | Running 2 tests 21:46:50 INFO - TEST-START | dromaeo_css 21:46:50 INFO - operating with platform_type : mac_ 21:46:50 INFO - Initialising browser for dromaeo_css test... 21:46:50 INFO - TEST-INFO | started process 1669 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmp0k7AeH/profile http://localhost:49276/getInfo.html) 21:46:53 INFO - PROCESS | 1669 | __metrics Screen width/height:1600/1200 21:46:53 INFO - PROCESS | 1669 | colorDepth:24 21:46:53 INFO - PROCESS | 1669 | Browser inner width/height: 1024/689 21:46:53 INFO - PROCESS | 1669 | __metrics 21:46:53 INFO - PROCESS | 1669 | 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" 21:46:53 ERROR - PROCESS | 1669 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 21:46:54 INFO - TEST-INFO | 1669: exit 0 21:46:54 INFO - Browser initialized. 21:46:54 INFO - Running cycle 1/1 for dromaeo_css test... 21:46:54 INFO - TEST-INFO | started process 1672 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmp0k7AeH/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:47:06 INFO - PROCESS | 1672 | RSS: Main: 245661696 21:47:06 INFO - PROCESS | 1672 | 21:47:57 INFO - PROCESS | 1672 | 1458794877544 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] 21:50:07 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 21:50:08 INFO - PROCESS | 1672 | RSS: Main: 398168064 21:50:08 INFO - PROCESS | 1672 | 21:53:11 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 21:53:12 INFO - PROCESS | 1672 | RSS: Main: 379908096 21:53:12 INFO - PROCESS | 1672 | 21:56:14 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 21:56:14 INFO - PROCESS | 1672 | RSS: Main: 377905152 21:56:14 INFO - PROCESS | 1672 | 21:59:16 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 21:59:17 INFO - PROCESS | 1672 | RSS: Main: 333873152 21:59:17 INFO - PROCESS | 1672 | 22:02:20 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 22:02:21 INFO - PROCESS | 1672 | RSS: Main: 335855616 22:02:21 INFO - PROCESS | 1672 | 22:05:23 INFO - PROCESS | 1672 | Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 22:05:24 INFO - PROCESS | 1672 | RSS: Main: 406519808 22:05:24 INFO - PROCESS | 1672 | 22:05:24 INFO - PROCESS | 1672 | __start_tp_report 22:05:24 INFO - PROCESS | 1672 | _x_x_mozilla_page_load 22:05:24 INFO - PROCESS | 1672 | _x_x_mozilla_page_load_details 22:05:24 INFO - PROCESS | 1672 | |i|pagename|runs| 22:05:24 INFO - PROCESS | 1672 | |0;dojo.html;3390.271091715281;3433.553638027058;3469.340825243205;3512.297540491902;3523.7533372663906;5418.620696551243;5518.034343989801;5524.392316845149;5527.55779537637;5553.750081246339;5492;5565.443455654433;5566.276384070075;5575.358833734122;5576.721163941807;5073.5941124710025;5106.514881086309;5125.755178008024;5130.897382052357;5187.273781670569;5162.354705661793;5167.069927413064;5176.378834539861;5181.145111056671;5181.507756763121;4570.245909424941;5119.462456442057;5137;5147.1764517677175;5175.249588809639;5129.281900533928;5162.12243918531;5167.4057483389515;5172.8965420691375;5235.293235413209;4910.607151427877;4979.7012179268995;5012.448630650625;5105.719185444799;5111.05445492585;5399.2980912481125;5414.702191379472;5469.234307196995;5487.725613719298;5547.667139971614;5675.801346952837;5910.852228694274;6124.601900876429;6135.447809697149;6154.199954005995;5062.82280120194;6030.185924900126;6118.021116621364;6134.405972711579;6194.659293738842;5646.011947909099;5677.233573467529;5678;5695.430456954313;5742.799002034909;6241.945034658107;6245.687715614201;6259.624422534572;6283.497320214372;6297.118403423525;5825.33008703996;5931.881362372728;6000.879982400327;6042.637441753509;6063.120847477091;5829.329627092854;5833.066709326487;5839.2992840858515;5846.269216347957;5902.173695682608;5737.254156959569;5775.104858746817;5779.739911703983;5783;5788.131780232915;5908.231929849178;5977.671228082497;6013.368596297413;6056.152138700585;6121.4490695837585;4791.808327666924;4801.591864691541;4804.759762011886;4809.278608208797;4852.757362131879;4103.4050062741335;4209.694994551699;4324.24325743;4336.046069864625;4345.652347812167;5477.643953143112;5576.247206627135;5579.6652200868075;5667.008273552112;5670.773169073191;6129.785457508966;6130.264368275746;6157.353477884847;6159.076138579159;6161.630302181883;5552.972235138879;5563.916541251884;5611.5230205433;5613.522850557748;5613.943860561424;4983.775730092155;5123.154679477919;5217.895642087137;5238.188080847474;5248.343957005374;6219;6234.0337247725765;6239.407256310643;6242.375762423903;6245.28179259391;5988.431099045583;6108.114323423168;6140.925338065731;6150.815475535741;6155;6166.229221347332;6174.44430001302;6259;6271;6277.058441233851;5996.910046349221;6050.776929677021;6053;6056.031035034373;6056.788012419544;5965.73154208053;6037.18498002764;6134.9632378475535;6153.323134455296;6193.907091393543;5479.780808767764;5759.4337271321465;5794.275715535558;5816.970915145566;5827.825165245049;5897.528197744256;5991.400859913973;6014.368491308524;6040.969795151172;6066.969665151646;5798.82603521895;5806.535477161901;5811.854703632274;5813.9534883721335;5838.2702162229725;5427.864303392446;5835.387284335084;5874.412558744091;5911.201987731773;6064.4541991221;5804.883902322014;5806.767729290781;5811.94188058114;5823.213866128019;5851.385604511465 22:05:24 INFO - PROCESS | 1672 | |1;ext.html;515.7704821354499;532.8294945617404;572.7279542217448;616.1374076293189;656.7569999100334;38943;39562.60437395629;39598.208035839336;39604.60395396045;39605.40591891124;42523.78738106313;42957.140857182836;43049.56950430495;43058.708238752806;43066.569334306645;9561.713148605553;9778.973207813184;9787.168090712263;9787.90212097877;9791.363561368524;9602.231821454301;9769.804603907953;9772.462514561696;9880.35777674449;9883.209343252522;9821.754456138582;9911.108000279974;9916.702498925044;9918.752031199205;9930.801383972317;9115.361924665276;9230.799996000544;9776.266779991494;9875.901240987641;9889.999999999964;9606.27952903535;9731.172850307732;9744.171745401649;9744.269179811543;9746.951265243628;41353.1729365411;41759;41780.79109604463;41786.79106604478;41897.37153942693;3237.514372844092;3281.885134020322;3419.6176498315367;3422.9144271393166;3503.2117773501013;29026.984055557954;29052.564211536843;29780.8306837043;30177;30399.544006839915;2747.4917140329103;2753.6833264174675;2760.4341110072387;2879.43850949065;2920.4305160493714;512876;513331;513944.9999999963;514482;514960;44494.33258501125;64419.677901610194;64648;65110;65362.67318663471;44129.55870441254;44294.557054429046;44317.55682443199;44354.77822610931;44373.67197460203;15813.604659883365;15999.840001599836;16005.519834404986;16030.438934637232;16048.197590120448;12791.552295669793;12868.871311286954;12870.485180592672;12870.970322374187;12888.033397495225;14357.92821035909;14453.421863125357;14612.926935365254;14663.706725865422;14690.926545367205;6349.777577847809;6451.903221451682;6481.740730370827;6517.3808488193545;6518.44593209573;805.4885147931105;981.3425005246502;998.5007496251874;1037.3827572594294;1157.7626586549736;29002.854985724935;29151.708482915325;29407.852960735487;29620.48780971362;29850.253743656147;989.9653512127041;1097.7914196302836;1118.2954738514684;1188.7741329147434;1197.9640610781692;11569.247998880046;13291.468341266242;13620.523281685093;14936.626584335261;14981.775273370908;532428;532694.0095898565;536630;537238;538474;59205;59858.40141598528;59972.700136499036;59998.70000649969;60339.39660603426;1349.9865001350058;1428.071753360324;1462.495439073518;1488.6724920517686;1497.0568541818584;28255;28898.711012889602;28942.855285723435;29024.56463153012;30435.847820760755;54553.72723136359;54764;55361;55361.72319138378;55390.89218215532;498461;510405;510471;510519;511950;36522.634773652986;42655;44725;44753.32870006887;45609;43044.35433468438;43069;43433.78283108564;43759.343609845244;43915.78042109769;35196.82401588078;36005.63994360023;36176;36876.446853297755;36949.81525092357;36191.81904090463;36517;36838.44742328813;37542.624573755005;37550.2489950194;36265.27469450543;36768.08079798026;37035.6296437043;37346.813265933495;37866.432003520524;31932.36135277235;33094.035894616;33312.666873330956;33386.833065834515;33458.832705836314;24496;24716.8207948013;24826.00695972141;25157.622635660115;25183.748162518874 22:05:24 INFO - PROCESS | 1672 | |2;jquery.html;283.33557806942724;309.94266060778773;356.80097467583334;358.1118825313221;358.5106329859742;19668.90165549172;19958.902260375675;20241.190352385904;20916.581668366623;20965.790342096574;11927.58253461129;18023.549411264692;19833.70249446256;20254.987250637445;20295.492612684655;5085.872853178682;5384.6499977501335;5389.245505629215;5391.649542779726;5395.946040539603;3850.441685955535;4036.5357983831796;5276.551493123089;5747.109198074284;6018.217631707872;6004.459598636122;6007.038873780196;6007.789727359544;6008.789692360769;6013.278406591216;5705.4579814917515;5972.25346831646;5977.731002104916;5979.162917191553;5998.700064996755;3796.316663000659;3956.2483128205836;3964.8414063437426;3973.205358928226;5714.399988001242;11825.940870295679;23452.64821027686;24056.51886962251;24468.755312446825;24560.385990350384;2068.979310206894;2177.803997640204;2223.788740069691;2559.9104031358997;2913.038697229909;8670.52312122833;9527.809443811155;9660.468674222915;9692.612295508172;10199.541020654015;1671.8996860188427;1681.2686481380638;1691.687037897993;1727.041491971955;1787.7229029500318;101241;105084;105506;105757.83784864761;108373.45813270884;10899.945500272606;11043.337399756041;11050.060744836617;11190.384528850991;11452.94273528627;13893.58319250424;13980.51068212628;13984.650383740487;13993.16041037541;14024.948128890373;7074;8515.531645759544;8573.099824518336;8772.38593298463;8859.202671759573;8701.390902636755;8896.42173258749;8909.064548222343;8989;9014.819703605892;4454.665900057508;4514.525974772667;4515.841945531956;4569.725816451024;4575.633949284049;1766.2405165778582;1821.1804687890503;1863.8788478748838;1888.952776180579;1922.8173323534243;906.1844340093968;906.5875026862761;921.6129225725211;949.188443880486;1022.0239671114068;14339.253544391635;19543.792165343133;19933.60132797365;20097.19611215564;20143.19427222924;862.8144948835904;943.7027336389016;958.736347504428;976.1361195342173;995.0795514149528;10718.517666705016;10972.561097556008;10978.560857565608;11115.610953616746;11120.499577519031;481015;496727.51636241586;497263;538148;603536;116032;120172.39913800375;121825;122118.38940805239;123731.38134309452;1014.9086582207636;1028.388109075099;1055.794120146564;1057.984130238047;1059.9258051936445;18476;18637;18815.341463048728;18826.811731883055;19004.904975475034;46507.53492465032;49163.01673966572;50127.74936125296;50578.68525896414;51520;72950;73528.48536359901;74004.88992665007;74172;76188;7740.26467485588;7931.603419829101;7941.682332706858;7975.880361794461;7985.161558036322;10477.42374169428;10500.842487362848;11449.542018319175;12173.878261217274;12793;4440.4671439427475;5416.593755468277;10054.748631283985;10462.790744184922;10783.676489705322;9787.412755234709;10526;10937.726556836144;11208.159388045766;11216.607418740305;10700.946495267473;10909.799922008731;11056.723581910517;11072.612458563912;11074.280171788809;6508.9349106508325;7471.775846724607;7657.272559106876;7734.071911370672;7746.147923728498;10035.297529172887;10855.945720271347;10950.39772812503;10981.890181098086;11010.834837477283 22:05:24 INFO - PROCESS | 1672 | |3;mootools.html;1383.8477767445581;1452.593273883313;1500.9399624015036;1850.54661607906;2061.7938206179383;8040.195980401957;8737.388382813198;8932.062133475973;8942.105789421063;8960;8579.699710510133;8824.249938755198;8830.381873268874;8840.071792461795;8859.51272680004;2454.1533171056003;2466.506698660266;2468.4075821802817;2468.4445999650025;2469.8641574713383;2112.42964399612;2414.5653782319177;2479.504099180162;2481.3548477395825;2492.0530198524534;2453.374389530667;2483.0936708101503;2488.054539275073;2491.1032028469735;2494.1395218649536;2439.3403417866593;2455.9263222103277;2459.8032157427365;2460.114358830828;2478.2689106713565;2456.803455723538;2489.6763420755187;2498.4128729748677;2503.1864643990775;2510.259473455335;8811.603477843513;8868.33487488441;8872.334574906909;8873.11268873114;8906.86639700405;5336.7865285388925;5498.615096943216;5536.944630553723;5541.5843811714285;5548.889022219573;3539;3607.2424790793966;3650.0692323457615;3695.7043436525014;3714.591394946554;1036.6371769880557;1054.4727636181908;1055.641082032105;1060.65528703171;1063.5214153630898;8957.731268061969;11717.179797414185;12010.519579216822;12013.759724805543;12018;4825.686330388514;4882.438519570223;4888.535589119028;4890.510948905081;4941.901161976813;10048.949755251177;10107.848382274271;10112.443815590066;10119.797604047877;10155.7461063474;5474.987127381447;5488.451154884559;5526.806561770319;5527.336719593594;5529.087700529368;4335.154644844225;4526.185286648369;4824.782884770194;4902.1176188285735;5018.222175562793;3291.9177020574675;3865.4588357629955;3919.8432062717743;3947.684185265172;3969.226000929791;1304.1457845111468;1314.9868501314863;1318.4133060787858;1324.5959982205327;1329.069651244133;981.5239608789874;1003.7390278527636;1007.9697609071593;1010.0354161775487;1132.3432409202642;7969.163237860057;8194.795130121676;8198.877016844752;8209.466384684976;8213.466124701876;1196;1213.3751118174148;1217.2939694976892;1221.7006833325893;1238.5293588436336;6118.785842495491;6130.356312587203;6211.3167551569295;6215.9378406216265;6222.315545290015;10519.631812886666;10937.4531273436;10943.56225750977;10961.451927403597;10989.175811814146;10565.841512377321;10580.206484513692;10601.575936962436;10701.250912436055;10812.189085818594;8273.751787446387;8405.873911891327;8449.662013519513;8454.915450845536;8459.49243045407;7841.137474877645;7899.289063984269;7946.7615971520945;7951.165127661512;7972.521648701097;9281.582328795355;9510.809783804423;9781.559829807533;9804.705858824247;9811.215102791903;9640.987696291788;9973.052560006789;10107.89892101099;10209.795804084026;10216.131628811634;7388.889166662397;7391.1869694334655;7428.294312040348;7462.179160292472;7513.30950536125;8198.508089514648;8224.794380140544;8267.214614611843;8271.83456330858;8284.792880178044;7317.8902316466365;7434.814129646802;7454.739084132029;7580.924190758022;7582.128055273714;7157.534760240567;7199.992001119952;7276.490645654753;7300.780976570712;7365.594892280976;7636.694532218649;7730.265624765639;7737.497062690907;7747.418943579141;7759.844803103793;6915.654217289216;6950.304969503211;7031.296870312928;7044.682989265393;7050.118735158106;7040.331168538981;7131.679074441767;7133.678984445609;7135.286471353031;7138.250483699345 22:05:24 INFO - PROCESS | 1672 | |4;prototype.html;303.6250230964759;324.1507251002374;330.6707037708411;331.1869360719433;333.9148517128132;6505.186851643544;6523.739050437983;6557.901631475532;6594.307597702232;6602.207735071792;6451.451626611732;6469.223693156816;6472.2233332000105;6506.251781045169;6524;4638.095571363586;4718.174319494092;4719.339292499036;4728.810847566093;4901.554041557749;4216.2199993001395;4551.954480455186;4720.716756994591;4765.404324459442;4798.47216806151;4779.976100119512;4806.615470762348;4810.639202059842;4820.614350851941;4827.08285425768;4789.185838407444;4802.183628783116;4805.567498925078;4807.615390768748;4814.2537906624175;3925.3523168677134;4052.5947405259535;4118.011677197481;4132.070284186064;4152.1695660867945;4746.928796068062;6211.65835879031;6228.346023667495;6229.968850155766;6236.251649802008;5674.716264186815;5680.131533575518;5682.914756278659;5684;5689.402612725646;6882.8967565486555;6894.379505844498;6898.0687607172895;6907.551009184437;6912.343327383891;4072.857449989236;4638.443386793607;4641.373414589055;4641.76791160444;4650.395448591696;5999.490043346321;6946.79159625212;7314.634268286618;7369.263073692641;7374.926250737478;4723.385959825201;4744.383230180124;4757.643176761757;4758.143534163814;4772.117158325721;4808.567228949411;4829.541193586604;4840.031993601294;4840.491748366441;4841.080194762983;5701.486866182064;5705.828825135252;5708.57185711065;5710.914336284959;5717.514011309002;6916.100906882174;6930.272321406281;6933.445324374139;6936.687849046704;6939.20199177091;1607.8954867933546;1681.9747703784453;1699.2608215426083;1701.1664284500505;1703.4804384662798;1028.88682244953;1062;1079.5465904320204;1105.7069876482738;1124.7469319403233;6288.213973253343;6460.483161347081;6511.251206111263;6527.836804079841;6534;7130.322619351154;7170.569765814068;7229.349358557755;7232.312930271616;7267.818304542428;6574.572652777554;6577.769778057745;6582.407583317428;6585.6377899216;6588.96705516479;3796.886093417202;3849.4225866119746;3857.18999010211;3861.826217820205;3872.1287710264965;7287.562746235243;7567.978322926335;7606.125295591078;7610.771676849703;7615.923840761521;7514.248575142551;7524.435667324972;7557.5465472071855;7560.773176804704;7581.6209189540305;7608.31525162738;7612.619369031637;7628.542287462659;7634.122075961224;7658.2724641159;7258.709651613876;7267.745628902963;7269.963650181927;7270.709171633075;7275.381592564479;6910.101686780687;7144.285571442814;7156.320149585989;7169.928300716926;7186.425085993213;6148.771894755289;7542.245775422414;7603.88594171099;7604.695812167452;7616.466847320635;4569.748663823521;4625.213713668617;4629.004763975761;4634.165850147006;4643.001754622773;7232.63836808147;7243.167035790952;7253.057102576631;7262.128544574685;7274.709011639475;6417.647029413427;6755.831104222434;6956.339147780953;7006.9649651751415;7043.401310888426;6962.303769622998;7015;7036.085308909809;7044.718211271492;7046.330598593126;5953.1367951647635;6826.692798823966;6826.8634627308165;6831.624260665512;6832.93167068323;6699.665016749241;7004.719811207495;7007.229204787572;7013.263607321362;7015;5504.779808807602;6741.887588548031;6851.760188393382;6863.0048642947495;6923.273056329214 22:05:24 INFO - PROCESS | 1672 | |5;yui.html;753.5892938348603;756.5725365168679;762.7559181062062;773.2344978471314;814.5357146426536;14958.925205373971;15236.542903712907;15253.542393728178;15266.313015914282;15268.236588170603;14085;14134.293285335718;14165.220912849789;14170;14184.936129790256;736.9631518424058;746.9290417410338;898.1602201941173;907.8865141857268;936.148105224246;797.6410615223173;900.7074847593691;915.6428992692855;931.3852857114306;931.7717159295981;966.6230170233614;980.8970058143899;981.6662334806165;982.6364245229275;984;782.6830133795793;789.1674283630796;790.8181118342756;965.9613615455373;966.2897770138942;735.4667865797254;736.8857827036818;736.9373603243731;738.3244331436729;739.4417215002638;15273.236338183046;15383.461578844686;15391.307391167424;15409.768853467207;15435.536933892;13014.284214368206;13044.217346959118;13095.541656041993;13304.667383315398;13387.330633468287;10087.596496140146;10150.340227885164;10203.795924081476;10234.692959211236;10564.154867610572;3068.861901214451;3537.7877327360184;3541;3703.148275896559;3710.666040056381;72395.63802181008;77570.22429775687;77655.61172194159;78434.60782696107;79614.99999999942;9239.445633262027;9323;9420.576074076684;9431.198348140484;10075.992400759866;21158.836264005626;21170.57658846845;21725.67411488829;21744.456388590097;21755.238566650092;7393.038904942323;7525.962370188224;7545.924540754632;7550.056242969629;7670.539767613849;3646.252518233756;4075.135622973103;4138.255114079434;4174.20690068886;4177.122804211089;3614.9096272593397;3656.8720094796554;3668.137987572918;3670.8531658733887;3674.2467794102145;542.2083757713704;565.5390856451978;656.4289068510332;662.2417332154656;669.9698513566901;514.6217530115363;525.8527612268571;579.8463407197096;580.3673995345009;614.5882258886556;6705.021024980258;7891.825078001158;8134.349252059821;8220.301274391744;8339.166083391734;528.577138289367;546.0062685911603;585.7422733997028;590.4715279824533;602.9276486821609;3642.2715456908722;3803.2393521295853;3836.4437156612694;3856.633619806114;3867.6325749053794;92685;93074;95689.52155239179;95710;95726.5213673941;78058.21941780623;78834;79127.41745165065;79379;80053.19946800574;66440.33559664438;67366.326336736;68151.50333463315;68930.62138757197;69242.61514769676;8272.503649781032;8321.833563328579;8516.531590762568;8523.91476085256;8598.355123365647;47080.7645961768;48153.07387704593;50196.996060077865;50237.74881125571;50679.493205067476;65740.39817212941;67451;68425;68569;71439.28560714326;10961.945190273998;11253.437328133397;11360.431978401211;11366.318020918772;11665.125115616533;11897.524099036287;12003.519859205533;12320.137590368588;12358.44387002569;12780.297083660487;7937.920620793718;11171;11425.885741142481;11612.825807612724;11617.361045142598;10730.517126729159;10759.677209683721;10899.836502452628;11810.940945295219;11857.229280096766;10950.890491094988;10992.28550144238;11085.667429976791;11239.943800280946;11349.319040857576;9067.125576953433;9236.953815230881;9329.72010839676;9527.761805954906;9639.084286992724;8800.339974502065;8957;9120.589573469342;9496.810063798546;9502.572384242863 22:05:24 INFO - PROCESS | 1672 | __end_tp_report 22:05:24 INFO - PROCESS | 1672 | __start_cc_report 22:05:24 INFO - PROCESS | 1672 | _x_x_mozilla_cycle_collect,1439 22:05:24 INFO - PROCESS | 1672 | __end_cc_report 22:05:24 INFO - PROCESS | 1672 | __startTimestamp1458795924008__endTimestamp 22:05:24 INFO - PROCESS | 1672 | 22:05:24 INFO - PROCESS | 1672 | ------- Summary: start ------- 22:05:24 INFO - PROCESS | 1672 | Number of tests: 6 22:05:24 INFO - PROCESS | 1672 | 22:05:24 INFO - PROCESS | 1672 | [#0] dojo.html Cycles:165 Average:5590.02 Median:5779.74 stddev:606.52 (10.5%) stddev-sans-first:583.32 22:05:24 INFO - PROCESS | 1672 | Values: 3390.3 3433.6 3469.3 3512.3 3523.8 5418.6 5518.0 5524.4 5527.6 5553.8 5492.0 5565.4 5566.3 5575.4 5576.7 5073.6 5106.5 5125.8 5130.9 5187.3 5162.4 5167.1 5176.4 5181.1 5181.5 4570.2 5119.5 5137.0 5147.2 5175.2 5129.3 5162.1 5167.4 5172.9 5235.3 4910.6 4979.7 5012.4 5105.7 5111.1 5399.3 5414.7 5469.2 5487.7 5547.7 5675.8 5910.9 6124.6 6135.4 6154.2 5062.8 6030.2 6118.0 6134.4 6194.7 5646.0 5677.2 5678.0 5695.4 5742.8 6241.9 6245.7 6259.6 6283.5 6297.1 5825.3 5931.9 6000.9 6042.6 6063.1 5829.3 5833.1 5839.3 5846.3 5902.2 5737.3 5775.1 5779.7 5783.0 5788.1 5908.2 5977.7 6013.4 6056.2 6121.4 4791.8 4801.6 4804.8 4809.3 4852.8 4103.4 4209.7 4324.2 4336.0 4345.7 5477.6 5576.2 5579.7 5667.0 5670.8 6129.8 6130.3 6157.4 6159.1 6161.6 5553.0 5563.9 5611.5 5613.5 5613.9 4983.8 5123.2 5217.9 5238.2 5248.3 6219.0 6234.0 6239.4 6242.4 6245.3 5988.4 6108.1 6140.9 6150.8 6155.0 6166.2 6174.4 6259.0 6271.0 6277.1 5996.9 6050.8 6053.0 6056.0 6056.8 5965.7 6037.2 6135.0 6153.3 6193.9 5479.8 5759.4 5794.3 5817.0 5827.8 5897.5 5991.4 6014.4 6041.0 6067.0 5798.8 5806.5 5811.9 5814.0 5838.3 5427.9 5835.4 5874.4 5911.2 6064.5 5804.9 5806.8 5811.9 5823.2 5851.4 22:05:24 INFO - PROCESS | 1672 | 22:05:24 INFO - PROCESS | 1672 | [#1] ext.html Cycles:180 Average:65754.49 Median:41842.08 stddev:138287.20 (330.5%) stddev-sans-first:138588.38 22:05:24 INFO - PROCESS | 1672 | Values: 515.8 532.8 572.7 616.1 656.8 38943.0 39562.6 39598.2 39604.6 39605.4 42523.8 42957.1 43049.6 43058.7 43066.6 9561.7 9779.0 9787.2 9787.9 9791.4 9602.2 9769.8 9772.5 9880.4 9883.2 9821.8 9911.1 9916.7 9918.8 9930.8 9115.4 9230.8 9776.3 9875.9 9890.0 9606.3 9731.2 9744.2 9744.3 9747.0 41353.2 41759.0 41780.8 41786.8 41897.4 3237.5 3281.9 3419.6 3422.9 3503.2 29027.0 29052.6 29780.8 30177.0 30399.5 2747.5 2753.7 2760.4 2879.4 2920.4 512876.0 513331.0 513945.0 514482.0 514960.0 44494.3 64419.7 64648.0 65110.0 65362.7 44129.6 44294.6 44317.6 44354.8 44373.7 15813.6 15999.8 16005.5 16030.4 16048.2 12791.6 12868.9 12870.5 12871.0 12888.0 14357.9 14453.4 14612.9 14663.7 14690.9 6349.8 6451.9 6481.7 6517.4 6518.4 805.5 981.3 998.5 1037.4 1157.8 29002.9 29151.7 29407.9 29620.5 29850.3 990.0 1097.8 1118.3 1188.8 1198.0 11569.2 13291.5 13620.5 14936.6 14981.8 532428.0 532694.0 536630.0 537238.0 538474.0 59205.0 59858.4 59972.7 59998.7 60339.4 1350.0 1428.1 1462.5 1488.7 1497.1 28255.0 28898.7 28942.9 29024.6 30435.8 54553.7 54764.0 55361.0 55361.7 55390.9 498461.0 510405.0 510471.0 510519.0 511950.0 36522.6 42655.0 44725.0 44753.3 45609.0 43044.4 43069.0 43433.8 43759.3 43915.8 35196.8 36005.6 36176.0 36876.4 36949.8 36191.8 36517.0 36838.4 37542.6 37550.2 36265.3 36768.1 37035.6 37346.8 37866.4 31932.4 33094.0 33312.7 33386.8 33458.8 24496.0 24716.8 24826.0 25157.6 25183.7 22:05:24 INFO - PROCESS | 1672 | 22:05:24 INFO - PROCESS | 1672 | [#2] jquery.html Cycles:180 Average:31705.35 Median:24514.57 stddev:87928.01 (358.7%) stddev-sans-first:88143.01 22:05:24 INFO - PROCESS | 1672 | Values: 283.3 309.9 356.8 358.1 358.5 19668.9 19958.9 20241.2 20916.6 20965.8 11927.6 18023.5 19833.7 20255.0 20295.5 5085.9 5384.6 5389.2 5391.6 5395.9 3850.4 4036.5 5276.6 5747.1 6018.2 6004.5 6007.0 6007.8 6008.8 6013.3 5705.5 5972.3 5977.7 5979.2 5998.7 3796.3 3956.2 3964.8 3973.2 5714.4 11825.9 23452.6 24056.5 24468.8 24560.4 2069.0 2177.8 2223.8 2559.9 2913.0 8670.5 9527.8 9660.5 9692.6 10199.5 1671.9 1681.3 1691.7 1727.0 1787.7 101241.0 105084.0 105506.0 105757.8 108373.5 10899.9 11043.3 11050.1 11190.4 11452.9 13893.6 13980.5 13984.7 13993.2 14024.9 7074.0 8515.5 8573.1 8772.4 8859.2 8701.4 8896.4 8909.1 8989.0 9014.8 4454.7 4514.5 4515.8 4569.7 4575.6 1766.2 1821.2 1863.9 1889.0 1922.8 906.2 906.6 921.6 949.2 1022.0 14339.3 19543.8 19933.6 20097.2 20143.2 862.8 943.7 958.7 976.1 995.1 10718.5 10972.6 10978.6 11115.6 11120.5 481015.0 496727.5 497263.0 538148.0 603536.0 116032.0 120172.4 121825.0 122118.4 123731.4 1014.9 1028.4 1055.8 1058.0 1059.9 18476.0 18637.0 18815.3 18826.8 19004.9 46507.5 49163.0 50127.7 50578.7 51520.0 72950.0 73528.5 74004.9 74172.0 76188.0 7740.3 7931.6 7941.7 7975.9 7985.2 10477.4 10500.8 11449.5 12173.9 12793.0 4440.5 5416.6 10054.7 10462.8 10783.7 9787.4 10526.0 10937.7 11208.2 11216.6 10700.9 10909.8 11056.7 11072.6 11074.3 6508.9 7471.8 7657.3 7734.1 7746.1 10035.3 10855.9 10950.4 10981.9 11010.8 22:05:24 INFO - PROCESS | 1672 | 22:05:24 INFO - PROCESS | 1672 | [#3] mootools.html Cycles:180 Average:6070.90 Median:5177.50 stddev:3193.64 (61.7%) stddev-sans-first:3183.16 22:05:24 INFO - PROCESS | 1672 | Values: 1383.8 1452.6 1500.9 1850.5 2061.8 8040.2 8737.4 8932.1 8942.1 8960.0 8579.7 8824.2 8830.4 8840.1 8859.5 2454.2 2466.5 2468.4 2468.4 2469.9 2112.4 2414.6 2479.5 2481.4 2492.1 2453.4 2483.1 2488.1 2491.1 2494.1 2439.3 2455.9 2459.8 2460.1 2478.3 2456.8 2489.7 2498.4 2503.2 2510.3 8811.6 8868.3 8872.3 8873.1 8906.9 5336.8 5498.6 5536.9 5541.6 5548.9 3539.0 3607.2 3650.1 3695.7 3714.6 1036.6 1054.5 1055.6 1060.7 1063.5 8957.7 11717.2 12010.5 12013.8 12018.0 4825.7 4882.4 4888.5 4890.5 4941.9 10048.9 10107.8 10112.4 10119.8 10155.7 5475.0 5488.5 5526.8 5527.3 5529.1 4335.2 4526.2 4824.8 4902.1 5018.2 3291.9 3865.5 3919.8 3947.7 3969.2 1304.1 1315.0 1318.4 1324.6 1329.1 981.5 1003.7 1008.0 1010.0 1132.3 7969.2 8194.8 8198.9 8209.5 8213.5 1196.0 1213.4 1217.3 1221.7 1238.5 6118.8 6130.4 6211.3 6215.9 6222.3 10519.6 10937.5 10943.6 10961.5 10989.2 10565.8 10580.2 10601.6 10701.3 10812.2 8273.8 8405.9 8449.7 8454.9 8459.5 7841.1 7899.3 7946.8 7951.2 7972.5 9281.6 9510.8 9781.6 9804.7 9811.2 9641.0 9973.1 10107.9 10209.8 10216.1 7388.9 7391.2 7428.3 7462.2 7513.3 8198.5 8224.8 8267.2 8271.8 8284.8 7317.9 7434.8 7454.7 7580.9 7582.1 7157.5 7200.0 7276.5 7300.8 7365.6 7636.7 7730.3 7737.5 7747.4 7759.8 6915.7 6950.3 7031.3 7044.7 7050.1 7040.3 7131.7 7133.7 7135.3 7138.3 22:05:24 INFO - PROCESS | 1672 | 22:05:24 INFO - PROCESS | 1672 | [#4] prototype.html Cycles:180 Average:5717.74 Median:6505.72 stddev:1814.46 (27.9%) stddev-sans-first:1773.46 22:05:24 INFO - PROCESS | 1672 | Values: 303.6 324.2 330.7 331.2 333.9 6505.2 6523.7 6557.9 6594.3 6602.2 6451.5 6469.2 6472.2 6506.3 6524.0 4638.1 4718.2 4719.3 4728.8 4901.6 4216.2 4552.0 4720.7 4765.4 4798.5 4780.0 4806.6 4810.6 4820.6 4827.1 4789.2 4802.2 4805.6 4807.6 4814.3 3925.4 4052.6 4118.0 4132.1 4152.2 4746.9 6211.7 6228.3 6230.0 6236.3 5674.7 5680.1 5682.9 5684.0 5689.4 6882.9 6894.4 6898.1 6907.6 6912.3 4072.9 4638.4 4641.4 4641.8 4650.4 5999.5 6946.8 7314.6 7369.3 7374.9 4723.4 4744.4 4757.6 4758.1 4772.1 4808.6 4829.5 4840.0 4840.5 4841.1 5701.5 5705.8 5708.6 5710.9 5717.5 6916.1 6930.3 6933.4 6936.7 6939.2 1607.9 1682.0 1699.3 1701.2 1703.5 1028.9 1062.0 1079.5 1105.7 1124.7 6288.2 6460.5 6511.3 6527.8 6534.0 7130.3 7170.6 7229.3 7232.3 7267.8 6574.6 6577.8 6582.4 6585.6 6589.0 3796.9 3849.4 3857.2 3861.8 3872.1 7287.6 7568.0 7606.1 7610.8 7615.9 7514.2 7524.4 7557.5 7560.8 7581.6 7608.3 7612.6 7628.5 7634.1 7658.3 7258.7 7267.7 7270.0 7270.7 7275.4 6910.1 7144.3 7156.3 7169.9 7186.4 6148.8 7542.2 7603.9 7604.7 7616.5 4569.7 4625.2 4629.0 4634.2 4643.0 7232.6 7243.2 7253.1 7262.1 7274.7 6417.6 6755.8 6956.3 7007.0 7043.4 6962.3 7015.0 7036.1 7044.7 7046.3 5953.1 6826.7 6826.9 6831.6 6832.9 6699.7 7004.7 7007.2 7013.3 7015.0 5504.8 6741.9 6851.8 6863.0 6923.3 22:05:24 INFO - PROCESS | 1672 | 22:05:24 INFO - PROCESS | 1672 | [#5] yui.html Cycles:180 Average:18235.70 Median:608.76 stddev:25613.35 (4207.5%) stddev-sans-first:25651.57 22:05:24 INFO - PROCESS | 1672 | Values: 753.6 756.6 762.8 773.2 814.5 14958.9 15236.5 15253.5 15266.3 15268.2 14085.0 14134.3 14165.2 14170.0 14184.9 737.0 746.9 898.2 907.9 936.1 797.6 900.7 915.6 931.4 931.8 966.6 980.9 981.7 982.6 984.0 782.7 789.2 790.8 966.0 966.3 735.5 736.9 736.9 738.3 739.4 15273.2 15383.5 15391.3 15409.8 15435.5 13014.3 13044.2 13095.5 13304.7 13387.3 10087.6 10150.3 10203.8 10234.7 10564.2 3068.9 3537.8 3541.0 3703.1 3710.7 72395.6 77570.2 77655.6 78434.6 79615.0 9239.4 9323.0 9420.6 9431.2 10076.0 21158.8 21170.6 21725.7 21744.5 21755.2 7393.0 7526.0 7545.9 7550.1 7670.5 3646.3 4075.1 4138.3 4174.2 4177.1 3614.9 3656.9 3668.1 3670.9 3674.2 542.2 565.5 656.4 662.2 670.0 514.6 525.9 579.8 580.4 614.6 6705.0 7891.8 8134.3 8220.3 8339.2 528.6 546.0 585.7 590.5 602.9 3642.3 3803.2 3836.4 3856.6 3867.6 92685.0 93074.0 95689.5 95710.0 95726.5 78058.2 78834.0 79127.4 79379.0 80053.2 66440.3 67366.3 68151.5 68930.6 69242.6 8272.5 8321.8 8516.5 8523.9 8598.4 47080.8 48153.1 50197.0 50237.7 50679.5 65740.4 67451.0 68425.0 68569.0 71439.3 10961.9 11253.4 11360.4 11366.3 11665.1 11897.5 12003.5 12320.1 12358.4 12780.3 7937.9 11171.0 11425.9 11612.8 11617.4 10730.5 10759.7 10899.8 11810.9 11857.2 10950.9 10992.3 11085.7 11239.9 11349.3 9067.1 9237.0 9329.7 9527.8 9639.1 8800.3 8957.0 9120.6 9496.8 9502.6 22:05:24 INFO - PROCESS | 1672 | -------- Summary: end -------- 22:05:24 INFO - PROCESS | 1672 | 22:05:24 INFO - TEST-INFO | 1672: exit 0 22:05:24 INFO - TEST-OK | dromaeo_css | took 1113614ms 22:05:24 INFO - TEST-START | kraken 22:05:24 INFO - operating with platform_type : mac_ 22:05:24 INFO - Initialising browser for kraken test... 22:05:24 INFO - TEST-INFO | started process 1678 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpopRsmL/profile http://localhost:49276/getInfo.html) 22:05:26 INFO - PROCESS | 1678 | __metrics Screen width/height:1600/1200 22:05:26 INFO - PROCESS | 1678 | colorDepth:24 22:05:26 INFO - PROCESS | 1678 | Browser inner width/height: 1024/689 22:05:26 INFO - PROCESS | 1678 | __metrics 22:05:26 INFO - PROCESS | 1678 | 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" 22:05:26 ERROR - PROCESS | 1678 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 22:05:27 INFO - TEST-INFO | 1678: exit 0 22:05:27 INFO - Browser initialized. 22:05:27 INFO - Running cycle 1/1 for kraken test... 22:05:27 INFO - TEST-INFO | started process 1680 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/T/tmpopRsmL/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 22:05:39 INFO - PROCESS | 1680 | RSS: Main: 247078912 22:05:39 INFO - PROCESS | 1680 | 22:05:42 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 22:05:42 INFO - PROCESS | 1680 | RSS: Main: 291835904 22:05:42 INFO - PROCESS | 1680 | 22:05:45 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 22:05:45 INFO - PROCESS | 1680 | RSS: Main: 303280128 22:05:45 INFO - PROCESS | 1680 | 22:05:49 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 22:05:49 INFO - PROCESS | 1680 | RSS: Main: 290344960 22:05:49 INFO - PROCESS | 1680 | 22:05:51 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 22:05:52 INFO - PROCESS | 1680 | RSS: Main: 292077568 22:05:52 INFO - PROCESS | 1680 | 22:05:54 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 22:05:54 INFO - PROCESS | 1680 | RSS: Main: 292110336 22:05:54 INFO - PROCESS | 1680 | 22:05:57 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 22:05:58 INFO - PROCESS | 1680 | RSS: Main: 293404672 22:05:58 INFO - PROCESS | 1680 | 22:06:01 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 22:06:01 INFO - PROCESS | 1680 | RSS: Main: 293466112 22:06:01 INFO - PROCESS | 1680 | 22:06:04 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 22:06:05 INFO - PROCESS | 1680 | RSS: Main: 294027264 22:06:05 INFO - PROCESS | 1680 | 22:06:06 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 22:06:07 INFO - PROCESS | 1680 | RSS: Main: 326582272 22:06:07 INFO - PROCESS | 1680 | 22:06:09 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 22:06:09 INFO - PROCESS | 1680 | RSS: Main: 327974912 22:06:09 INFO - PROCESS | 1680 | 22:06:11 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 22:06:12 INFO - PROCESS | 1680 | RSS: Main: 332918784 22:06:12 INFO - PROCESS | 1680 | 22:06:15 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 22:06:15 INFO - PROCESS | 1680 | RSS: Main: 333836288 22:06:15 INFO - PROCESS | 1680 | 22:06:18 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 22:06:18 INFO - PROCESS | 1680 | RSS: Main: 334356480 22:06:18 INFO - PROCESS | 1680 | 22:06:20 INFO - PROCESS | 1680 | Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 22:06:20 INFO - PROCESS | 1680 | RSS: Main: 394563584 22:06:20 INFO - PROCESS | 1680 | 22:06:20 INFO - PROCESS | 1680 | __start_tp_report 22:06:20 INFO - PROCESS | 1680 | _x_x_mozilla_page_load 22:06:20 INFO - PROCESS | 1680 | _x_x_mozilla_page_load_details 22:06:20 INFO - PROCESS | 1680 | |i|pagename|runs| 22:06:20 INFO - PROCESS | 1680 | |0;ai-astar;111;109;151;162;116;109;116;112;112;110 22:06:20 INFO - PROCESS | 1680 | |1;audio-beat-detection;155;119;144;155;118;140;143;115;157;117 22:06:20 INFO - PROCESS | 1680 | |2;audio-dft;181;182;183;190;184;183;183;190;246;182 22:06:20 INFO - PROCESS | 1680 | |3;audio-fft;78;80;75;120;55;57;58;59;121;44 22:06:20 INFO - PROCESS | 1680 | |4;audio-oscillator;88;95;127;80;77;86;117;79;78;119 22:06:20 INFO - PROCESS | 1680 | |5;imaging-gaussian-blur;86;84;87;85;126;84;87;84;87;83 22:06:20 INFO - PROCESS | 1680 | |6;imaging-darkroom;92;102;135;92;103;130;92;95;131;149 22:06:20 INFO - PROCESS | 1680 | |7;imaging-desaturate;88;87;85;86;88;87;86;87;81;72 22:06:20 INFO - PROCESS | 1680 | |8;json-parse-financial;56;54;54;54;54;54;53;65;55;54 22:06:20 INFO - PROCESS | 1680 | |9;json-stringify-tinderbox;64;65;68;76;75;71;67;67;69;70 22:06:20 INFO - PROCESS | 1680 | |10;stanford-crypto-aes;84;82;82;81;101;109;107;107;83;84 22:06:20 INFO - PROCESS | 1680 | |11;stanford-crypto-ccm;128;127;134;127;128;120;118;120;122;116 22:06:20 INFO - PROCESS | 1680 | |12;stanford-crypto-pbkdf2;138;127;136;137;137;161;134;141;140;172 22:06:20 INFO - PROCESS | 1680 | |13;stanford-crypto-sha256-iterative;67;68;67;67;67;63;64;68;55;76 22:06:20 INFO - PROCESS | 1680 | __end_tp_report 22:06:20 INFO - PROCESS | 1680 | __start_cc_report 22:06:20 INFO - PROCESS | 1680 | _x_x_mozilla_cycle_collect,1275 22:06:20 INFO - PROCESS | 1680 | __end_cc_report 22:06:20 INFO - PROCESS | 1680 | __startTimestamp1458795980807__endTimestamp 22:06:20 INFO - PROCESS | 1680 | 22:06:20 INFO - PROCESS | 1680 | ------- Summary: start ------- 22:06:20 INFO - PROCESS | 1680 | Number of tests: 14 22:06:20 INFO - PROCESS | 1680 | 22:06:20 INFO - PROCESS | 1680 | [#0] ai-astar Cycles:10 Average:120.80 Median:114.00 stddev:19.15 (16.8%) stddev-sans-first:19.98 22:06:20 INFO - PROCESS | 1680 | Values: 111.0 109.0 151.0 162.0 116.0 109.0 116.0 112.0 112.0 110.0 22:06:20 INFO - PROCESS | 1680 | 22:06:20 INFO - PROCESS | 1680 | [#1] audio-beat-detection Cycles:10 Average:136.30 Median:143.50 stddev:17.34 (12.1%) stddev-sans-first:17.02 22:06:20 INFO - PROCESS | 1680 | Values: 155.0 119.0 144.0 155.0 118.0 140.0 143.0 115.0 157.0 117.0 22:06:20 INFO - PROCESS | 1680 | 22:06:20 INFO - PROCESS | 1680 | [#2] audio-dft Cycles:10 Average:190.40 Median:183.50 stddev:19.79 (10.8%) stddev-sans-first:20.70 22:06:20 INFO - PROCESS | 1680 | Values: 181.0 182.0 183.0 190.0 184.0 183.0 183.0 190.0 246.0 182.0 22:06:20 INFO - PROCESS | 1680 | 22:06:20 INFO - PROCESS | 1680 | [#3] audio-fft Cycles:10 Average:74.70 Median:58.50 stddev:26.68 (45.6%) stddev-sans-first:28.27 22:06:20 INFO - PROCESS | 1680 | Values: 78.0 80.0 75.0 120.0 55.0 57.0 58.0 59.0 121.0 44.0 22:06:20 INFO - PROCESS | 1680 | 22:06:20 INFO - PROCESS | 1680 | [#4] audio-oscillator Cycles:10 Average:94.60 Median:79.50 stddev:19.17 (24.1%) stddev-sans-first:20.18 22:06:20 INFO - PROCESS | 1680 | Values: 88.0 95.0 127.0 80.0 77.0 86.0 117.0 79.0 78.0 119.0 22:06:20 INFO - PROCESS | 1680 | 22:06:20 INFO - PROCESS | 1680 | [#5] imaging-gaussian-blur Cycles:10 Average:89.30 Median:85.50 stddev:12.98 (15.2%) stddev-sans-first:13.71 22:06:20 INFO - PROCESS | 1680 | Values: 86.0 84.0 87.0 85.0 126.0 84.0 87.0 84.0 87.0 83.0 22:06:20 INFO - PROCESS | 1680 | 22:06:20 INFO - PROCESS | 1680 | [#6] imaging-darkroom Cycles:10 Average:112.10 Median:120.50 stddev:21.74 (18.0%) stddev-sans-first:21.81 22:06:20 INFO - PROCESS | 1680 | Values: 92.0 102.0 135.0 92.0 103.0 130.0 92.0 95.0 131.0 149.0 22:06:20 INFO - PROCESS | 1680 | 22:06:20 INFO - PROCESS | 1680 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:87.00 stddev:4.90 (5.6%) stddev-sans-first:5.05 22:06:20 INFO - PROCESS | 1680 | Values: 88.0 87.0 85.0 86.0 88.0 87.0 86.0 87.0 81.0 72.0 22:06:20 INFO - PROCESS | 1680 | 22:06:20 INFO - PROCESS | 1680 | [#8] json-parse-financial Cycles:10 Average:55.30 Median:54.00 stddev:3.50 (6.5%) stddev-sans-first:3.70 22:06:20 INFO - PROCESS | 1680 | Values: 56.0 54.0 54.0 54.0 54.0 54.0 53.0 65.0 55.0 54.0 22:06:20 INFO - PROCESS | 1680 | 22:06:20 INFO - PROCESS | 1680 | [#9] json-stringify-tinderbox Cycles:10 Average:69.20 Median:69.50 stddev:3.94 (5.7%) stddev-sans-first:3.70 22:06:20 INFO - PROCESS | 1680 | Values: 64.0 65.0 68.0 76.0 75.0 71.0 67.0 67.0 69.0 70.0 22:06:20 INFO - PROCESS | 1680 | 22:06:20 INFO - PROCESS | 1680 | [#10] stanford-crypto-aes Cycles:10 Average:92.00 Median:82.00 stddev:12.25 (14.9%) stddev-sans-first:12.64 22:06:20 INFO - PROCESS | 1680 | Values: 84.0 82.0 82.0 81.0 101.0 109.0 107.0 107.0 83.0 84.0 22:06:20 INFO - PROCESS | 1680 | 22:06:20 INFO - PROCESS | 1680 | [#11] stanford-crypto-ccm Cycles:10 Average:124.00 Median:127.00 stddev:5.64 (4.4%) stddev-sans-first:5.79 22:06:20 INFO - PROCESS | 1680 | Values: 128.0 127.0 134.0 127.0 128.0 120.0 118.0 120.0 122.0 116.0 22:06:20 INFO - PROCESS | 1680 | 22:06:20 INFO - PROCESS | 1680 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:142.30 Median:139.00 stddev:13.57 (9.8%) stddev-sans-first:14.30 22:06:20 INFO - PROCESS | 1680 | Values: 138.0 127.0 136.0 137.0 137.0 161.0 134.0 141.0 140.0 172.0 22:06:20 INFO - PROCESS | 1680 | 22:06:20 INFO - PROCESS | 1680 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.20 Median:67.00 stddev:5.22 (7.8%) stddev-sans-first:5.53 22:06:20 INFO - PROCESS | 1680 | Values: 67.0 68.0 67.0 67.0 67.0 63.0 64.0 68.0 55.0 76.0 22:06:20 INFO - PROCESS | 1680 | -------- Summary: end -------- 22:06:20 INFO - PROCESS | 1680 | 22:06:21 INFO - TEST-INFO | 1680: exit 0 22:06:21 INFO - TEST-OK | kraken | took 56988ms 22:06:21 INFO - SUITE-END | took 1170s 22:06:21 INFO - Completed test suite (00:19:30) 22:06:21 INFO - javascript benchmark 22:06:22 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3390.271091715281, 3433.553638027058, 3469.340825243205, 3512.297540491902, 3523.7533372663906, 5418.620696551243, 5518.034343989801, 5524.392316845149, 5527.55779537637, 5553.750081246339, 5492.0, 5565.443455654433, 5566.276384070075, 5575.358833734122, 5576.721163941807, 5073.5941124710025, 5106.514881086309, 5125.755178008024, 5130.897382052357, 5187.273781670569, 5162.354705661793, 5167.069927413064, 5176.378834539861, 5181.145111056671, 5181.507756763121, 4570.245909424941, 5119.462456442057, 5137.0, 5147.1764517677175, 5175.249588809639, 5129.281900533928, 5162.12243918531, 5167.4057483389515, 5172.8965420691375, 5235.293235413209, 4910.607151427877, 4979.7012179268995, 5012.448630650625, 5105.719185444799, 5111.05445492585, 5399.2980912481125, 5414.702191379472, 5469.234307196995, 5487.725613719298, 5547.667139971614, 5675.801346952837, 5910.852228694274, 6124.601900876429, 6135.447809697149, 6154.199954005995, 5062.82280120194, 6030.185924900126, 6118.021116621364, 6134.405972711579, 6194.659293738842, 5646.011947909099, 5677.233573467529, 5678.0, 5695.430456954313, 5742.799002034909, 6241.945034658107, 6245.687715614201, 6259.624422534572, 6283.497320214372, 6297.118403423525, 5825.33008703996, 5931.881362372728, 6000.879982400327, 6042.637441753509, 6063.120847477091, 5829.329627092854, 5833.066709326487, 5839.2992840858515, 5846.269216347957, 5902.173695682608, 5737.254156959569, 5775.104858746817, 5779.739911703983, 5783.0, 5788.131780232915, 5908.231929849178, 5977.671228082497, 6013.368596297413, 6056.152138700585, 6121.4490695837585, 4791.808327666924, 4801.591864691541, 4804.759762011886, 4809.278608208797, 4852.757362131879, 4103.4050062741335, 4209.694994551699, 4324.24325743, 4336.046069864625, 4345.652347812167, 5477.643953143112, 5576.247206627135, 5579.6652200868075, 5667.008273552112, 5670.773169073191, 6129.785457508966, 6130.264368275746, 6157.353477884847, 6159.076138579159, 6161.630302181883, 5552.972235138879, 5563.916541251884, 5611.5230205433, 5613.522850557748, 5613.943860561424, 4983.775730092155, 5123.154679477919, 5217.895642087137, 5238.188080847474, 5248.343957005374, 6219.0, 6234.0337247725765, 6239.407256310643, 6242.375762423903, 6245.28179259391, 5988.431099045583, 6108.114323423168, 6140.925338065731, 6150.815475535741, 6155.0, 6166.229221347332, 6174.44430001302, 6259.0, 6271.0, 6277.058441233851, 5996.910046349221, 6050.776929677021, 6053.0, 6056.031035034373, 6056.788012419544, 5965.73154208053, 6037.18498002764, 6134.9632378475535, 6153.323134455296, 6193.907091393543, 5479.780808767764, 5759.4337271321465, 5794.275715535558, 5816.970915145566, 5827.825165245049, 5897.528197744256, 5991.400859913973, 6014.368491308524, 6040.969795151172, 6066.969665151646, 5798.82603521895, 5806.535477161901, 5811.854703632274, 5813.9534883721335, 5838.2702162229725, 5427.864303392446, 5835.387284335084, 5874.412558744091, 5911.201987731773, 6064.4541991221, 5804.883902322014, 5806.767729290781, 5811.94188058114, 5823.213866128019, 5851.385604511465], "unit": "score", "name": "dojo.html", "value": 5553.3612305397855}, {"lowerIsBetter": false, "replicates": [515.7704821354499, 532.8294945617404, 572.7279542217448, 616.1374076293189, 656.7569999100334, 38943.0, 39562.60437395629, 39598.208035839336, 39604.60395396045, 39605.40591891124, 42523.78738106313, 42957.140857182836, 43049.56950430495, 43058.708238752806, 43066.569334306645, 9561.713148605553, 9778.973207813184, 9787.168090712263, 9787.90212097877, 9791.363561368524, 9602.231821454301, 9769.804603907953, 9772.462514561696, 9880.35777674449, 9883.209343252522, 9821.754456138582, 9911.108000279974, 9916.702498925044, 9918.752031199205, 9930.801383972317, 9115.361924665276, 9230.799996000544, 9776.266779991494, 9875.901240987641, 9889.999999999964, 9606.27952903535, 9731.172850307732, 9744.171745401649, 9744.269179811543, 9746.951265243628, 41353.1729365411, 41759.0, 41780.79109604463, 41786.79106604478, 41897.37153942693, 3237.514372844092, 3281.885134020322, 3419.6176498315367, 3422.9144271393166, 3503.2117773501013, 29026.984055557954, 29052.564211536843, 29780.8306837043, 30177.0, 30399.544006839915, 2747.4917140329103, 2753.6833264174675, 2760.4341110072387, 2879.43850949065, 2920.4305160493714, 512876.0, 513331.0, 513944.9999999963, 514482.0, 514960.0, 44494.33258501125, 64419.677901610194, 64648.0, 65110.0, 65362.67318663471, 44129.55870441254, 44294.557054429046, 44317.55682443199, 44354.77822610931, 44373.67197460203, 15813.604659883365, 15999.840001599836, 16005.519834404986, 16030.438934637232, 16048.197590120448, 12791.552295669793, 12868.871311286954, 12870.485180592672, 12870.970322374187, 12888.033397495225, 14357.92821035909, 14453.421863125357, 14612.926935365254, 14663.706725865422, 14690.926545367205, 6349.777577847809, 6451.903221451682, 6481.740730370827, 6517.3808488193545, 6518.44593209573, 805.4885147931105, 981.3425005246502, 998.5007496251874, 1037.3827572594294, 1157.7626586549736, 29002.854985724935, 29151.708482915325, 29407.852960735487, 29620.48780971362, 29850.253743656147, 989.9653512127041, 1097.7914196302836, 1118.2954738514684, 1188.7741329147434, 1197.9640610781692, 11569.247998880046, 13291.468341266242, 13620.523281685093, 14936.626584335261, 14981.775273370908, 532428.0, 532694.0095898565, 536630.0, 537238.0, 538474.0, 59205.0, 59858.40141598528, 59972.700136499036, 59998.70000649969, 60339.39660603426, 1349.9865001350058, 1428.071753360324, 1462.495439073518, 1488.6724920517686, 1497.0568541818584, 28255.0, 28898.711012889602, 28942.855285723435, 29024.56463153012, 30435.847820760755, 54553.72723136359, 54764.0, 55361.0, 55361.72319138378, 55390.89218215532, 498461.0, 510405.0, 510471.0, 510519.0, 511950.0, 36522.634773652986, 42655.0, 44725.0, 44753.32870006887, 45609.0, 43044.35433468438, 43069.0, 43433.78283108564, 43759.343609845244, 43915.78042109769, 35196.82401588078, 36005.63994360023, 36176.0, 36876.446853297755, 36949.81525092357, 36191.81904090463, 36517.0, 36838.44742328813, 37542.624573755005, 37550.2489950194, 36265.27469450543, 36768.08079798026, 37035.6296437043, 37346.813265933495, 37866.432003520524, 31932.36135277235, 33094.035894616, 33312.666873330956, 33386.833065834515, 33458.832705836314, 24496.0, 24716.8207948013, 24826.00695972141, 25157.622635660115, 25183.748162518874], "unit": "score", "name": "ext.html", "value": 19627.409495821794}, {"lowerIsBetter": false, "replicates": [283.33557806942724, 309.94266060778773, 356.80097467583334, 358.1118825313221, 358.5106329859742, 19668.90165549172, 19958.902260375675, 20241.190352385904, 20916.581668366623, 20965.790342096574, 11927.58253461129, 18023.549411264692, 19833.70249446256, 20254.987250637445, 20295.492612684655, 5085.872853178682, 5384.6499977501335, 5389.245505629215, 5391.649542779726, 5395.946040539603, 3850.441685955535, 4036.5357983831796, 5276.551493123089, 5747.109198074284, 6018.217631707872, 6004.459598636122, 6007.038873780196, 6007.789727359544, 6008.789692360769, 6013.278406591216, 5705.4579814917515, 5972.25346831646, 5977.731002104916, 5979.162917191553, 5998.700064996755, 3796.316663000659, 3956.2483128205836, 3964.8414063437426, 3973.205358928226, 5714.399988001242, 11825.940870295679, 23452.64821027686, 24056.51886962251, 24468.755312446825, 24560.385990350384, 2068.979310206894, 2177.803997640204, 2223.788740069691, 2559.9104031358997, 2913.038697229909, 8670.52312122833, 9527.809443811155, 9660.468674222915, 9692.612295508172, 10199.541020654015, 1671.8996860188427, 1681.2686481380638, 1691.687037897993, 1727.041491971955, 1787.7229029500318, 101241.0, 105084.0, 105506.0, 105757.83784864761, 108373.45813270884, 10899.945500272606, 11043.337399756041, 11050.060744836617, 11190.384528850991, 11452.94273528627, 13893.58319250424, 13980.51068212628, 13984.650383740487, 13993.16041037541, 14024.948128890373, 7074.0, 8515.531645759544, 8573.099824518336, 8772.38593298463, 8859.202671759573, 8701.390902636755, 8896.42173258749, 8909.064548222343, 8989.0, 9014.819703605892, 4454.665900057508, 4514.525974772667, 4515.841945531956, 4569.725816451024, 4575.633949284049, 1766.2405165778582, 1821.1804687890503, 1863.8788478748838, 1888.952776180579, 1922.8173323534243, 906.1844340093968, 906.5875026862761, 921.6129225725211, 949.188443880486, 1022.0239671114068, 14339.253544391635, 19543.792165343133, 19933.60132797365, 20097.19611215564, 20143.19427222924, 862.8144948835904, 943.7027336389016, 958.736347504428, 976.1361195342173, 995.0795514149528, 10718.517666705016, 10972.561097556008, 10978.560857565608, 11115.610953616746, 11120.499577519031, 481015.0, 496727.51636241586, 497263.0, 538148.0, 603536.0, 116032.0, 120172.39913800375, 121825.0, 122118.38940805239, 123731.38134309452, 1014.9086582207636, 1028.388109075099, 1055.794120146564, 1057.984130238047, 1059.9258051936445, 18476.0, 18637.0, 18815.341463048728, 18826.811731883055, 19004.904975475034, 46507.53492465032, 49163.01673966572, 50127.74936125296, 50578.68525896414, 51520.0, 72950.0, 73528.48536359901, 74004.88992665007, 74172.0, 76188.0, 7740.26467485588, 7931.603419829101, 7941.682332706858, 7975.880361794461, 7985.161558036322, 10477.42374169428, 10500.842487362848, 11449.542018319175, 12173.878261217274, 12793.0, 4440.4671439427475, 5416.593755468277, 10054.748631283985, 10462.790744184922, 10783.676489705322, 9787.412755234709, 10526.0, 10937.726556836144, 11208.159388045766, 11216.607418740305, 10700.946495267473, 10909.799922008731, 11056.723581910517, 11072.612458563912, 11074.280171788809, 6508.9349106508325, 7471.775846724607, 7657.272559106876, 7734.071911370672, 7746.147923728498, 10035.297529172887, 10855.945720271347, 10950.39772812503, 10981.890181098086, 11010.834837477283], "unit": "score", "name": "jquery.html", "value": 9030.362929449437}, {"lowerIsBetter": false, "replicates": [1383.8477767445581, 1452.593273883313, 1500.9399624015036, 1850.54661607906, 2061.7938206179383, 8040.195980401957, 8737.388382813198, 8932.062133475973, 8942.105789421063, 8960.0, 8579.699710510133, 8824.249938755198, 8830.381873268874, 8840.071792461795, 8859.51272680004, 2454.1533171056003, 2466.506698660266, 2468.4075821802817, 2468.4445999650025, 2469.8641574713383, 2112.42964399612, 2414.5653782319177, 2479.504099180162, 2481.3548477395825, 2492.0530198524534, 2453.374389530667, 2483.0936708101503, 2488.054539275073, 2491.1032028469735, 2494.1395218649536, 2439.3403417866593, 2455.9263222103277, 2459.8032157427365, 2460.114358830828, 2478.2689106713565, 2456.803455723538, 2489.6763420755187, 2498.4128729748677, 2503.1864643990775, 2510.259473455335, 8811.603477843513, 8868.33487488441, 8872.334574906909, 8873.11268873114, 8906.86639700405, 5336.7865285388925, 5498.615096943216, 5536.944630553723, 5541.5843811714285, 5548.889022219573, 3539.0, 3607.2424790793966, 3650.0692323457615, 3695.7043436525014, 3714.591394946554, 1036.6371769880557, 1054.4727636181908, 1055.641082032105, 1060.65528703171, 1063.5214153630898, 8957.731268061969, 11717.179797414185, 12010.519579216822, 12013.759724805543, 12018.0, 4825.686330388514, 4882.438519570223, 4888.535589119028, 4890.510948905081, 4941.901161976813, 10048.949755251177, 10107.848382274271, 10112.443815590066, 10119.797604047877, 10155.7461063474, 5474.987127381447, 5488.451154884559, 5526.806561770319, 5527.336719593594, 5529.087700529368, 4335.154644844225, 4526.185286648369, 4824.782884770194, 4902.1176188285735, 5018.222175562793, 3291.9177020574675, 3865.4588357629955, 3919.8432062717743, 3947.684185265172, 3969.226000929791, 1304.1457845111468, 1314.9868501314863, 1318.4133060787858, 1324.5959982205327, 1329.069651244133, 981.5239608789874, 1003.7390278527636, 1007.9697609071593, 1010.0354161775487, 1132.3432409202642, 7969.163237860057, 8194.795130121676, 8198.877016844752, 8209.466384684976, 8213.466124701876, 1196.0, 1213.3751118174148, 1217.2939694976892, 1221.7006833325893, 1238.5293588436336, 6118.785842495491, 6130.356312587203, 6211.3167551569295, 6215.9378406216265, 6222.315545290015, 10519.631812886666, 10937.4531273436, 10943.56225750977, 10961.451927403597, 10989.175811814146, 10565.841512377321, 10580.206484513692, 10601.575936962436, 10701.250912436055, 10812.189085818594, 8273.751787446387, 8405.873911891327, 8449.662013519513, 8454.915450845536, 8459.49243045407, 7841.137474877645, 7899.289063984269, 7946.7615971520945, 7951.165127661512, 7972.521648701097, 9281.582328795355, 9510.809783804423, 9781.559829807533, 9804.705858824247, 9811.215102791903, 9640.987696291788, 9973.052560006789, 10107.89892101099, 10209.795804084026, 10216.131628811634, 7388.889166662397, 7391.1869694334655, 7428.294312040348, 7462.179160292472, 7513.30950536125, 8198.508089514648, 8224.794380140544, 8267.214614611843, 8271.83456330858, 8284.792880178044, 7317.8902316466365, 7434.814129646802, 7454.739084132029, 7580.924190758022, 7582.128055273714, 7157.534760240567, 7199.992001119952, 7276.490645654753, 7300.780976570712, 7365.594892280976, 7636.694532218649, 7730.265624765639, 7737.497062690907, 7747.418943579141, 7759.844803103793, 6915.654217289216, 6950.304969503211, 7031.296870312928, 7044.682989265393, 7050.118735158106, 7040.331168538981, 7131.679074441767, 7133.678984445609, 7135.286471353031, 7138.250483699345], "unit": "score", "name": "mootools.html", "value": 4938.894969350618}, {"lowerIsBetter": false, "replicates": [303.6250230964759, 324.1507251002374, 330.6707037708411, 331.1869360719433, 333.9148517128132, 6505.186851643544, 6523.739050437983, 6557.901631475532, 6594.307597702232, 6602.207735071792, 6451.451626611732, 6469.223693156816, 6472.2233332000105, 6506.251781045169, 6524.0, 4638.095571363586, 4718.174319494092, 4719.339292499036, 4728.810847566093, 4901.554041557749, 4216.2199993001395, 4551.954480455186, 4720.716756994591, 4765.404324459442, 4798.47216806151, 4779.976100119512, 4806.615470762348, 4810.639202059842, 4820.614350851941, 4827.08285425768, 4789.185838407444, 4802.183628783116, 4805.567498925078, 4807.615390768748, 4814.2537906624175, 3925.3523168677134, 4052.5947405259535, 4118.011677197481, 4132.070284186064, 4152.1695660867945, 4746.928796068062, 6211.65835879031, 6228.346023667495, 6229.968850155766, 6236.251649802008, 5674.716264186815, 5680.131533575518, 5682.914756278659, 5684.0, 5689.402612725646, 6882.8967565486555, 6894.379505844498, 6898.0687607172895, 6907.551009184437, 6912.343327383891, 4072.857449989236, 4638.443386793607, 4641.373414589055, 4641.76791160444, 4650.395448591696, 5999.490043346321, 6946.79159625212, 7314.634268286618, 7369.263073692641, 7374.926250737478, 4723.385959825201, 4744.383230180124, 4757.643176761757, 4758.143534163814, 4772.117158325721, 4808.567228949411, 4829.541193586604, 4840.031993601294, 4840.491748366441, 4841.080194762983, 5701.486866182064, 5705.828825135252, 5708.57185711065, 5710.914336284959, 5717.514011309002, 6916.100906882174, 6930.272321406281, 6933.445324374139, 6936.687849046704, 6939.20199177091, 1607.8954867933546, 1681.9747703784453, 1699.2608215426083, 1701.1664284500505, 1703.4804384662798, 1028.88682244953, 1062.0, 1079.5465904320204, 1105.7069876482738, 1124.7469319403233, 6288.213973253343, 6460.483161347081, 6511.251206111263, 6527.836804079841, 6534.0, 7130.322619351154, 7170.569765814068, 7229.349358557755, 7232.312930271616, 7267.818304542428, 6574.572652777554, 6577.769778057745, 6582.407583317428, 6585.6377899216, 6588.96705516479, 3796.886093417202, 3849.4225866119746, 3857.18999010211, 3861.826217820205, 3872.1287710264965, 7287.562746235243, 7567.978322926335, 7606.125295591078, 7610.771676849703, 7615.923840761521, 7514.248575142551, 7524.435667324972, 7557.5465472071855, 7560.773176804704, 7581.6209189540305, 7608.31525162738, 7612.619369031637, 7628.542287462659, 7634.122075961224, 7658.2724641159, 7258.709651613876, 7267.745628902963, 7269.963650181927, 7270.709171633075, 7275.381592564479, 6910.101686780687, 7144.285571442814, 7156.320149585989, 7169.928300716926, 7186.425085993213, 6148.771894755289, 7542.245775422414, 7603.88594171099, 7604.695812167452, 7616.466847320635, 4569.748663823521, 4625.213713668617, 4629.004763975761, 4634.165850147006, 4643.001754622773, 7232.63836808147, 7243.167035790952, 7253.057102576631, 7262.128544574685, 7274.709011639475, 6417.647029413427, 6755.831104222434, 6956.339147780953, 7006.9649651751415, 7043.401310888426, 6962.303769622998, 7015.0, 7036.085308909809, 7044.718211271492, 7046.330598593126, 5953.1367951647635, 6826.692798823966, 6826.8634627308165, 6831.624260665512, 6832.93167068323, 6699.665016749241, 7004.719811207495, 7007.229204787572, 7013.263607321362, 7015.0, 5504.779808807602, 6741.887588548031, 6851.760188393382, 6863.0048642947495, 6923.273056329214], "unit": "score", "name": "prototype.html", "value": 5113.844663037554}, {"lowerIsBetter": false, "replicates": [753.5892938348603, 756.5725365168679, 762.7559181062062, 773.2344978471314, 814.5357146426536, 14958.925205373971, 15236.542903712907, 15253.542393728178, 15266.313015914282, 15268.236588170603, 14085.0, 14134.293285335718, 14165.220912849789, 14170.0, 14184.936129790256, 736.9631518424058, 746.9290417410338, 898.1602201941173, 907.8865141857268, 936.148105224246, 797.6410615223173, 900.7074847593691, 915.6428992692855, 931.3852857114306, 931.7717159295981, 966.6230170233614, 980.8970058143899, 981.6662334806165, 982.6364245229275, 984.0, 782.6830133795793, 789.1674283630796, 790.8181118342756, 965.9613615455373, 966.2897770138942, 735.4667865797254, 736.8857827036818, 736.9373603243731, 738.3244331436729, 739.4417215002638, 15273.236338183046, 15383.461578844686, 15391.307391167424, 15409.768853467207, 15435.536933892, 13014.284214368206, 13044.217346959118, 13095.541656041993, 13304.667383315398, 13387.330633468287, 10087.596496140146, 10150.340227885164, 10203.795924081476, 10234.692959211236, 10564.154867610572, 3068.861901214451, 3537.7877327360184, 3541.0, 3703.148275896559, 3710.666040056381, 72395.63802181008, 77570.22429775687, 77655.61172194159, 78434.60782696107, 79614.99999999942, 9239.445633262027, 9323.0, 9420.576074076684, 9431.198348140484, 10075.992400759866, 21158.836264005626, 21170.57658846845, 21725.67411488829, 21744.456388590097, 21755.238566650092, 7393.038904942323, 7525.962370188224, 7545.924540754632, 7550.056242969629, 7670.539767613849, 3646.252518233756, 4075.135622973103, 4138.255114079434, 4174.20690068886, 4177.122804211089, 3614.9096272593397, 3656.8720094796554, 3668.137987572918, 3670.8531658733887, 3674.2467794102145, 542.2083757713704, 565.5390856451978, 656.4289068510332, 662.2417332154656, 669.9698513566901, 514.6217530115363, 525.8527612268571, 579.8463407197096, 580.3673995345009, 614.5882258886556, 6705.021024980258, 7891.825078001158, 8134.349252059821, 8220.301274391744, 8339.166083391734, 528.577138289367, 546.0062685911603, 585.7422733997028, 590.4715279824533, 602.9276486821609, 3642.2715456908722, 3803.2393521295853, 3836.4437156612694, 3856.633619806114, 3867.6325749053794, 92685.0, 93074.0, 95689.52155239179, 95710.0, 95726.5213673941, 78058.21941780623, 78834.0, 79127.41745165065, 79379.0, 80053.19946800574, 66440.33559664438, 67366.326336736, 68151.50333463315, 68930.62138757197, 69242.61514769676, 8272.503649781032, 8321.833563328579, 8516.531590762568, 8523.91476085256, 8598.355123365647, 47080.7645961768, 48153.07387704593, 50196.996060077865, 50237.74881125571, 50679.493205067476, 65740.39817212941, 67451.0, 68425.0, 68569.0, 71439.28560714326, 10961.945190273998, 11253.437328133397, 11360.431978401211, 11366.318020918772, 11665.125115616533, 11897.524099036287, 12003.519859205533, 12320.137590368588, 12358.44387002569, 12780.297083660487, 7937.920620793718, 11171.0, 11425.885741142481, 11612.825807612724, 11617.361045142598, 10730.517126729159, 10759.677209683721, 10899.836502452628, 11810.940945295219, 11857.229280096766, 10950.890491094988, 10992.28550144238, 11085.667429976791, 11239.943800280946, 11349.319040857576, 9067.125576953433, 9236.953815230881, 9329.72010839676, 9527.761805954906, 9639.084286992724, 8800.339974502065, 8957.0, 9120.589573469342, 9496.810063798546, 9502.572384242863], "unit": "score", "name": "yui.html", "value": 6875.012419840926}], "name": "dromaeo_css", "value": 7449.633892875888}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 109.0, 151.0, 162.0, 116.0, 109.0, 116.0, 112.0, 112.0, 110.0], "unit": "score", "name": "ai-astar", "value": 120.8}, {"lowerIsBetter": true, "replicates": [155.0, 119.0, 144.0, 155.0, 118.0, 140.0, 143.0, 115.0, 157.0, 117.0], "unit": "score", "name": "audio-beat-detection", "value": 136.3}, {"lowerIsBetter": true, "replicates": [181.0, 182.0, 183.0, 190.0, 184.0, 183.0, 183.0, 190.0, 246.0, 182.0], "unit": "score", "name": "audio-dft", "value": 190.4}, {"lowerIsBetter": true, "replicates": [78.0, 80.0, 75.0, 120.0, 55.0, 57.0, 58.0, 59.0, 121.0, 44.0], "unit": "score", "name": "audio-fft", "value": 74.7}, {"lowerIsBetter": true, "replicates": [88.0, 95.0, 127.0, 80.0, 77.0, 86.0, 117.0, 79.0, 78.0, 119.0], "unit": "score", "name": "audio-oscillator", "value": 94.6}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 87.0, 85.0, 126.0, 84.0, 87.0, 84.0, 87.0, 83.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 89.3}, {"lowerIsBetter": true, "replicates": [92.0, 102.0, 135.0, 92.0, 103.0, 130.0, 92.0, 95.0, 131.0, 149.0], "unit": "score", "name": "imaging-darkroom", "value": 112.1}, {"lowerIsBetter": true, "replicates": [88.0, 87.0, 85.0, 86.0, 88.0, 87.0, 86.0, 87.0, 81.0, 72.0], "unit": "score", "name": "imaging-desaturate", "value": 84.7}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 54.0, 54.0, 54.0, 54.0, 53.0, 65.0, 55.0, 54.0], "unit": "score", "name": "json-parse-financial", "value": 55.3}, {"lowerIsBetter": true, "replicates": [64.0, 65.0, 68.0, 76.0, 75.0, 71.0, 67.0, 67.0, 69.0, 70.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 69.2}, {"lowerIsBetter": true, "replicates": [84.0, 82.0, 82.0, 81.0, 101.0, 109.0, 107.0, 107.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 92.0}, {"lowerIsBetter": true, "replicates": [128.0, 127.0, 134.0, 127.0, 128.0, 120.0, 118.0, 120.0, 122.0, 116.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 124.0}, {"lowerIsBetter": true, "replicates": [138.0, 127.0, 136.0, 137.0, 137.0, 161.0, 134.0, 141.0, 140.0, 172.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 142.3}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 67.0, 67.0, 63.0, 64.0, 68.0, 55.0, 76.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.2}], "name": "kraken", "value": 1451.9}]} 22:06:22 INFO - Return code: 0 22:06:22 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 22:06:22 ERROR - # TBPL SUCCESS # 22:06:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 22:06:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 22:06:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 22:06:22 INFO - 2016-03-23 22:06:22.119 screenresolution[1684:10022] starting screenresolution argv=screenresolution get 22:06:22 INFO - 2016-03-23 22:06:22.122 screenresolution[1684:10022] Display 0: 1600x1200x32@60 22:06:22 INFO - 2016-03-23 22:06:22.128 screenresolution[1685:10025] starting screenresolution argv=screenresolution list 22:06:22 INFO - Available Modes on Display 0 22:06:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 22:06:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 22:06:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 22:06:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 22:06:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 22:06:22 INFO - Intel Iris: 22:06:22 INFO - Chipset Model: Intel Iris 22:06:22 INFO - Type: GPU 22:06:22 INFO - Bus: Built-In 22:06:22 INFO - VRAM (Dynamic, Max): 1536 MB 22:06:22 INFO - Vendor: Intel (0x8086) 22:06:22 INFO - Device ID: 0x0a2e 22:06:22 INFO - Revision ID: 0x0009 22:06:22 INFO - Displays: 22:06:22 INFO - Display: 22:06:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 22:06:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 22:06:22 INFO - Display Serial Number: 1600x1200 60 22:06:22 INFO - Main Display: Yes 22:06:22 INFO - Mirror: Off 22:06:22 INFO - Online: Yes 22:06:22 INFO - Rotation: Supported 22:06:22 INFO - Return code: 0 22:06:22 INFO - Running post-action listener: _resource_record_post_action 22:06:22 INFO - Running post-run listener: _resource_record_post_run 22:06:23 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 45711872; Write bytes: 713252352; Read time: 534; Write time: 2199 22:06:23 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 400693760; Write bytes: 394549248; Read time: 30621; Write time: 682 22:06:23 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 43749888; Write bytes: 307627520; Read time: 509; Write time: 1485 22:06:23 INFO - Running post-run listener: _upload_blobber_files 22:06:23 INFO - Blob upload gear active. 22:06:23 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 22:06:23 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 22:06:23 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'] 22:06:23 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 22:06:23 INFO - (blobuploader) - INFO - Open directory for files ... 22:06:23 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 22:06:23 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:23 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:06:24 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 22:06:24 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:06:24 INFO - (blobuploader) - INFO - Done attempting. 22:06:24 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 22:06:24 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 22:06:24 INFO - (blobuploader) - INFO - Uploading, attempt #1. 22:06:26 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 22:06:26 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 22:06:26 INFO - (blobuploader) - INFO - Done attempting. 22:06:26 INFO - (blobuploader) - INFO - Iteration through files over. 22:06:26 INFO - Return code: 0 22:06:26 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 22:06:26 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 22:06:26 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d53f6756d79aed014025029676419ab90f01c3e96ddcd0b92cd141fd929a4613f81eaf21b1f1ae6435a42e19398fb030ea61615521a827b771ba83aac1779f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f37c3dfdce17d5f2081f38245325a700981c552edccfccd5a0767bf9969a465ac2df431f3b40b98666eb31cb7443cc74008ef0203a3ce28d891b1d543273fbe"} 22:06:26 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 22:06:26 INFO - Writing to file /builds/slave/test/properties/blobber_files 22:06:26 INFO - Contents: 22:06:26 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2d53f6756d79aed014025029676419ab90f01c3e96ddcd0b92cd141fd929a4613f81eaf21b1f1ae6435a42e19398fb030ea61615521a827b771ba83aac1779f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f37c3dfdce17d5f2081f38245325a700981c552edccfccd5a0767bf9969a465ac2df431f3b40b98666eb31cb7443cc74008ef0203a3ce28d891b1d543273fbe"} 22:06:26 INFO - Running post-run listener: copy_logs_to_upload_dir 22:06:26 INFO - Copying logs to upload dir... 22:06:26 INFO - mkdir: /builds/slave/test/build/upload/logs 22:06:26 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1349.478603 ========= master_lag: 117.12 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 24 mins, 26 secs) (at 2016-03-23 22:08:23.236811) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 25 secs) (at 2016-03-23 22:08:23.240963) ========= 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.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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/2d53f6756d79aed014025029676419ab90f01c3e96ddcd0b92cd141fd929a4613f81eaf21b1f1ae6435a42e19398fb030ea61615521a827b771ba83aac1779f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f37c3dfdce17d5f2081f38245325a700981c552edccfccd5a0767bf9969a465ac2df431f3b40b98666eb31cb7443cc74008ef0203a3ce28d891b1d543273fbe"} build_url:https://queue.taskcluster.net/v1/task/YOXdP892Q3GAIVqa7mFBBg/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011302 build_url: 'https://queue.taskcluster.net/v1/task/YOXdP892Q3GAIVqa7mFBBg/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/2d53f6756d79aed014025029676419ab90f01c3e96ddcd0b92cd141fd929a4613f81eaf21b1f1ae6435a42e19398fb030ea61615521a827b771ba83aac1779f8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7f37c3dfdce17d5f2081f38245325a700981c552edccfccd5a0767bf9969a465ac2df431f3b40b98666eb31cb7443cc74008ef0203a3ce28d891b1d543273fbe"}' ========= master_lag: 25.36 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 25 secs) (at 2016-03-23 22:08:48.613528) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 40 secs) (at 2016-03-23 22:08:48.613828) ========= 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.L2aO45RPHJ/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.Sfpk5tlVtn/Listeners TMPDIR=/var/folders/ng/0q61k9nx7_qgv5x7bgjycqqw00000w/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.006047 ========= master_lag: 40.77 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 40 secs) (at 2016-03-23 22:09:29.390985) ========= ========= Started reboot skipped (results: 3, elapsed: 2 mins, 12 secs) (at 2016-03-23 22:09:29.391255) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 mins, 12 secs) (at 2016-03-23 22:11:42.267084) ========= ========= Total master_lag: 184.16 =========