builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0130 starttime: 1458956034.66 results: success (0) buildid: 20160325165039 builduid: 0970b2e723fa4df4a0929483891ee182 revision: 070628989f86334dfd35ae04c5f5151bdb8589a3 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:54.662571) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:54.662984) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:54.663270) ========= 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.cXcwYnKK4w/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.jdS7eBJWeD/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.005663 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:54.689394) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:54.693688) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:54.709842) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:54.710114) ========= 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.cXcwYnKK4w/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.jdS7eBJWeD/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.005343 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:54.758335) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:54.758635) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:54.758974) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:54.759244) ========= 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.cXcwYnKK4w/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.jdS7eBJWeD/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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-25 18:33:54-- 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% 8.28M=0.001s 2016-03-25 18:33:54 (8.28 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.171674 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:54.950005) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:54.950312) ========= 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.cXcwYnKK4w/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.jdS7eBJWeD/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.020616 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:55.002309) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-25 18:33:55.005674) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 070628989f86334dfd35ae04c5f5151bdb8589a3 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 070628989f86334dfd35ae04c5f5151bdb8589a3 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cXcwYnKK4w/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.jdS7eBJWeD/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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-25 18:33:55,083 truncating revision to first 12 chars 2016-03-25 18:33:55,083 Setting DEBUG logging. 2016-03-25 18:33:55,083 attempt 1/10 2016-03-25 18:33:55,083 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/070628989f86?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-25 18:33:56,583 unpacking tar archive at: fx-team-070628989f86/testing/mozharness/ program finished with exit code 0 elapsedTime=1.819241 ========= master_lag: 0.14 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-25 18:33:56.968242) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:56.971618) ========= echo 070628989f86334dfd35ae04c5f5151bdb8589a3 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'070628989f86334dfd35ae04c5f5151bdb8589a3'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cXcwYnKK4w/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.jdS7eBJWeD/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 070628989f86334dfd35ae04c5f5151bdb8589a3 program finished with exit code 0 elapsedTime=0.004514 script_repo_revision: '070628989f86334dfd35ae04c5f5151bdb8589a3' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:56.991830) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:56.992107) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-03-25 18:33:57.009001) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-25 18:33:57.009274) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 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', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cXcwYnKK4w/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.jdS7eBJWeD/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 18:33:57 INFO - MultiFileLogger online at 20160325 18:33:57 in /builds/slave/test 18:33:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 18:33:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:33:57 INFO - {'append_to_log': False, 18:33:57 INFO - 'base_work_dir': '/builds/slave/test', 18:33:57 INFO - 'blob_upload_branch': 'Fx-Team', 18:33:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:33:57 INFO - 'branch': 'Fx-Team', 18:33:57 INFO - 'buildbot_json_path': 'buildprops.json', 18:33:57 INFO - 'config_files': ('talos/mac_config.py',), 18:33:57 INFO - 'default_actions': ('clobber', 18:33:57 INFO - 'read-buildbot-config', 18:33:57 INFO - 'download-and-extract', 18:33:57 INFO - 'populate-webroot', 18:33:57 INFO - 'create-virtualenv', 18:33:57 INFO - 'install', 18:33:57 INFO - 'run-tests'), 18:33:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:33:57 INFO - 'download_minidump_stackwalk': True, 18:33:57 INFO - 'download_symbols': 'ondemand', 18:33:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:33:57 INFO - 'tooltool.py': '/tools/tooltool.py', 18:33:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:33:57 INFO - '/tools/misc-python/virtualenv.py')}, 18:33:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:33:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:33:57 INFO - 'installer_path': 'installer.exe', 18:33:57 INFO - 'log_level': 'info', 18:33:57 INFO - 'log_name': 'talos', 18:33:57 INFO - 'log_to_console': True, 18:33:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:33:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:33:57 INFO - 'opt_config_files': (), 18:33:57 INFO - 'pip_index': False, 18:33:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:33:57 INFO - 'cmd': ('bash', 18:33:57 INFO - '-c', 18:33:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:33:57 INFO - 'enabled': True, 18:33:57 INFO - 'halt_on_failure': False, 18:33:57 INFO - 'name': 'check_screen_resolution'},), 18:33:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:33:57 INFO - 'cmd': ('bash', 18:33:57 INFO - '-c', 18:33:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:33:57 INFO - 'enabled': True, 18:33:57 INFO - 'halt_on_failure': False, 18:33:57 INFO - 'name': 'check_screen_resolution'},), 18:33:57 INFO - 'run_cmd_checks_enabled': True, 18:33:57 INFO - 'sps_profile': False, 18:33:57 INFO - 'sps_profile_interval': 0, 18:33:57 INFO - 'suite': 'dromaeojs', 18:33:57 INFO - 'system_bits': '32', 18:33:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:33:57 INFO - 'title': 't-yosemite-r7-0130', 18:33:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:33:57 INFO - 'use_talos_json': True, 18:33:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:33:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:33:57 INFO - 'work_dir': 'build'} 18:33:57 INFO - ##### 18:33:57 INFO - ##### Running clobber step. 18:33:57 INFO - ##### 18:33:57 INFO - Running pre-action listener: _resource_record_pre_action 18:33:57 INFO - Running main action method: clobber 18:33:57 INFO - rmtree: /builds/slave/test/build 18:33:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:33:58 INFO - Running post-action listener: _resource_record_post_action 18:33:58 INFO - ##### 18:33:58 INFO - ##### Running read-buildbot-config step. 18:33:58 INFO - ##### 18:33:58 INFO - Running pre-action listener: _resource_record_pre_action 18:33:58 INFO - Running main action method: read_buildbot_config 18:33:58 INFO - Using buildbot properties: 18:33:58 INFO - { 18:33:58 INFO - "project": "", 18:33:58 INFO - "product": "firefox", 18:33:58 INFO - "script_repo_revision": "production", 18:33:58 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 18:33:58 INFO - "repository": "", 18:33:58 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 18:33:58 INFO - "buildid": "20160325165039", 18:33:58 INFO - "pgo_build": "False", 18:33:58 INFO - "basedir": "/builds/slave/test", 18:33:58 INFO - "buildnumber": 630, 18:33:58 INFO - "slavename": "t-yosemite-r7-0130", 18:33:58 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 18:33:58 INFO - "platform": "yosemite_r7", 18:33:58 INFO - "scheduler": "tests-fx-team-macosx64-talos", 18:33:58 INFO - "branch": "fx-team", 18:33:58 INFO - "repo_path": "integration/fx-team", 18:33:58 INFO - "revision": "070628989f86334dfd35ae04c5f5151bdb8589a3", 18:33:58 INFO - "stage_platform": "macosx64", 18:33:58 INFO - "builduid": "0970b2e723fa4df4a0929483891ee182", 18:33:58 INFO - "slavebuilddir": "test" 18:33:58 INFO - } 18:33:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 18:33:58 INFO - Running post-action listener: _resource_record_post_action 18:33:58 INFO - ##### 18:33:58 INFO - ##### Running download-and-extract step. 18:33:58 INFO - ##### 18:33:58 INFO - Running pre-action listener: _resource_record_pre_action 18:33:58 INFO - Running main action method: download_and_extract 18:33:58 INFO - mkdir: /builds/slave/test/build/tests 18:33: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')]} 18:33:58 INFO - https://queue.taskcluster.net/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 18:33:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:33:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 18:33:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/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 18:33:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/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 18:34:00 INFO - Downloaded 1199 bytes. 18:34:00 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 18:34:00 INFO - Using the following test package requirements: 18:34:00 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:34:00 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:34:00 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 18:34:00 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:34:00 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 18:34:00 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:34:00 INFO - u'jsshell-mac.zip'], 18:34:00 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:34:00 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 18:34:00 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 18:34:00 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:34:00 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 18:34:00 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:34:00 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 18:34:00 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:34:00 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 18:34:00 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 18:34:00 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 18:34:00 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:34: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')]} 18:34:00 INFO - https://queue.taskcluster.net/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:34:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:34:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:34:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/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 18:34:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/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 18:34:01 INFO - Downloaded 17943701 bytes. 18:34:01 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'] 18:34:01 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 18:34:04 INFO - Return code: 0 18:34:04 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 18:34:04 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')]} 18:34:04 INFO - https://queue.taskcluster.net/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:34:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:34:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 18:34:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/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 18:34:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/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 18:34:06 INFO - Downloaded 17943701 bytes. 18:34:06 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'] 18:34:06 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 18:34:09 INFO - Return code: 0 18:34: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')]} 18:34:09 INFO - https://queue.taskcluster.net/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:34:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:34:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 18:34:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/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 18:34:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/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 18:34:11 INFO - Downloaded 10847531 bytes. 18:34:11 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'] 18:34:11 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 18:34:11 INFO - Return code: 0 18:34:11 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')]} 18:34:11 INFO - https://queue.taskcluster.net/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:34:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:34:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:34:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 18:34:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/M6lyarfHQtaYmkssFxSO0w/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 18:34:15 INFO - Downloaded 111387685 bytes. 18:34:15 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:34:15 INFO - mkdir: /builds/slave/test/properties 18:34:15 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:34:15 INFO - Writing to file /builds/slave/test/properties/build_url 18:34:15 INFO - Contents: 18:34:15 INFO - build_url:https://queue.taskcluster.net/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 18:34:17 INFO - Running post-action listener: _resource_record_post_action 18:34:17 INFO - Running post-action listener: set_extra_try_arguments 18:34:17 INFO - ##### 18:34:17 INFO - ##### Running populate-webroot step. 18:34:17 INFO - ##### 18:34:17 INFO - Running pre-action listener: _resource_record_pre_action 18:34:17 INFO - Running main action method: populate_webroot 18:34:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:34:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:34:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:34:17 INFO - '--tppagecycles', 18:34:17 INFO - '7'], 18:34:17 INFO - 'tests': ['tsvgm']}}, 18:34:17 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:34:17 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:34:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:34:17 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 18:34:17 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:34:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 18:34:17 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:34:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:34:17 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:34:17 INFO - 'talos_options': ['--e10s'], 18:34:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:34:17 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:34:17 INFO - 'tests': ['damp', 'tps']}, 18:34:17 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:34:17 INFO - 'talos_options': ['--e10s'], 18:34:17 INFO - 'tests': ['damp', 'tps']}, 18:34:17 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:34:17 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 18:34:17 INFO - 'tests': ['dromaeo_dom']}, 18:34:17 INFO - 'other': {'tests': ['a11yr', 18:34:17 INFO - 'ts_paint', 18:34:17 INFO - 'tpaint', 18:34:17 INFO - 'sessionrestore', 18:34:17 INFO - 'sessionrestore_no_auto_restore', 18:34:17 INFO - 'tabpaint']}, 18:34:17 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:34:17 INFO - 'tests': ['a11yr', 18:34:17 INFO - 'ts_paint', 18:34:17 INFO - 'tpaint', 18:34:17 INFO - 'sessionrestore', 18:34:17 INFO - 'sessionrestore_no_auto_restore', 18:34:17 INFO - 'tabpaint']}, 18:34:17 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:34:17 INFO - 'tests': ['a11yr', 18:34:17 INFO - 'ts_paint', 18:34:17 INFO - 'tpaint', 18:34:17 INFO - 'sessionrestore', 18:34:17 INFO - 'sessionrestore_no_auto_restore', 18:34:17 INFO - 'tabpaint']}, 18:34:17 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:34:17 INFO - 'tests': ['a11yr', 18:34:17 INFO - 'ts_paint', 18:34:17 INFO - 'tpaint', 18:34:17 INFO - 'sessionrestore', 18:34:17 INFO - 'sessionrestore_no_auto_restore', 18:34:17 INFO - 'tabpaint']}, 18:34:17 INFO - 'other_l64': {'tests': ['a11yr', 18:34:17 INFO - 'ts_paint', 18:34:17 INFO - 'tpaint', 18:34:17 INFO - 'sessionrestore', 18:34:17 INFO - 'sessionrestore_no_auto_restore', 18:34:17 INFO - 'tabpaint']}, 18:34:17 INFO - 'other_nol64': {'tests': ['a11yr', 18:34:17 INFO - 'ts_paint', 18:34:17 INFO - 'tpaint', 18:34:17 INFO - 'sessionrestore', 18:34:17 INFO - 'sessionrestore_no_auto_restore', 18:34:17 INFO - 'tabpaint']}, 18:34:17 INFO - 'svgr': {'tests': ['tsvgx', 18:34:17 INFO - 'tsvgr_opacity', 18:34:17 INFO - 'tart', 18:34:17 INFO - 'tscrollx', 18:34:17 INFO - 'cart']}, 18:34:17 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:34:17 INFO - 'tests': ['tsvgx', 18:34:17 INFO - 'tsvgr_opacity', 18:34:17 INFO - 'tart', 18:34:17 INFO - 'tscrollx', 18:34:17 INFO - 'cart']}, 18:34:17 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:34:17 INFO - 'tests': ['tp5o']}, 18:34:17 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:34:17 INFO - 'talos_options': ['--e10s'], 18:34:17 INFO - 'tests': ['tp5o']}, 18:34:17 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:34:17 INFO - 'talos_options': ['--xperf_path', 18:34:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:34:17 INFO - 'tests': ['tp5n']}, 18:34:17 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:34:17 INFO - 'talos_options': ['--e10s', 18:34:17 INFO - '--xperf_path', 18:34:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:34:17 INFO - 'tests': ['tp5n']}}, 18:34:17 INFO - 'talos.zip': {'path': '', 18:34:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:34:17 INFO - Running post-action listener: _resource_record_post_action 18:34:17 INFO - ##### 18:34:17 INFO - ##### Running create-virtualenv step. 18:34:17 INFO - ##### 18:34:17 INFO - Running pre-action listener: _resource_record_pre_action 18:34:17 INFO - Running main action method: create_virtualenv 18:34:17 INFO - Creating virtualenv /builds/slave/test/build/venv 18:34:17 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 18:34:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:34:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:34:17 INFO - Using real prefix '/tools/python27' 18:34:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:34:18 INFO - Installing distribute.............................................................................................................................................................................................done. 18:34:21 INFO - Installing pip.................done. 18:34:21 INFO - Return code: 0 18:34:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:34:21 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')]} 18:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:21 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')]} 18:34:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:21 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 0x105118a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105128420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1ca4bd2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fb7e00>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fb2b20>, '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.cXcwYnKK4w/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.jdS7eBJWeD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 18:34:21 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 18:34:21 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 18:34:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cXcwYnKK4w/Render', 18:34:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:21 INFO - 'HOME': '/Users/cltbld', 18:34:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:21 INFO - 'LOGNAME': 'cltbld', 18:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:21 INFO - 'MOZ_NO_REMOTE': '1', 18:34:21 INFO - 'NO_EM_RESTART': '1', 18:34:21 INFO - 'PAGER': '/bin/cat', 18:34:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:21 INFO - 'PWD': '/builds/slave/test', 18:34:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:21 INFO - 'SHELL': '/bin/bash', 18:34:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdS7eBJWeD/Listeners', 18:34:21 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:34:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:21 INFO - 'USER': 'cltbld', 18:34:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:21 INFO - 'XPC_FLAGS': '0x0', 18:34:21 INFO - 'XPC_SERVICE_NAME': '0', 18:34:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:21 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 18:34:21 INFO - Cleaning up... 18:34:21 INFO - Return code: 0 18:34:21 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:34:21 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')]} 18:34:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:21 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')]} 18:34:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:21 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 0x105118a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105128420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1ca4bd2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fb7e00>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fb2b20>, '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.cXcwYnKK4w/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.jdS7eBJWeD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 18:34:21 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 18:34:21 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 18:34:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cXcwYnKK4w/Render', 18:34:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:21 INFO - 'HOME': '/Users/cltbld', 18:34:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:21 INFO - 'LOGNAME': 'cltbld', 18:34:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:21 INFO - 'MOZ_NO_REMOTE': '1', 18:34:21 INFO - 'NO_EM_RESTART': '1', 18:34:21 INFO - 'PAGER': '/bin/cat', 18:34:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:21 INFO - 'PWD': '/builds/slave/test', 18:34:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:21 INFO - 'SHELL': '/bin/bash', 18:34:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdS7eBJWeD/Listeners', 18:34:21 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:34:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:21 INFO - 'USER': 'cltbld', 18:34:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:21 INFO - 'XPC_FLAGS': '0x0', 18:34:21 INFO - 'XPC_SERVICE_NAME': '0', 18:34:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:21 INFO - Downloading/unpacking psutil>=0.7.1 18:34:21 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 18:34:21 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 18:34:21 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 18:34:21 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 18:34:21 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 18:34:21 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 18:34:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:34:24 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:34:24 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:34:24 INFO - Installing collected packages: psutil 18:34:24 INFO - Running setup.py install for psutil 18:34:24 INFO - building 'psutil._psutil_osx' extension 18:34:24 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 18:34:25 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 18:34:25 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 18:34:25 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 18:34:25 INFO - building 'psutil._psutil_posix' extension 18:34:25 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 18:34:25 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:34:25 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:34:25 INFO - ^ 18:34:25 INFO - 1 warning generated. 18:34:25 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 18:34:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:34:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:34:25 INFO - Successfully installed psutil 18:34:25 INFO - Cleaning up... 18:34:25 INFO - Return code: 0 18:34:25 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:34:25 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')]} 18:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:25 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')]} 18:34:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:25 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 0x105118a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105128420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1ca4bd2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fb7e00>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fb2b20>, '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.cXcwYnKK4w/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.jdS7eBJWeD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 18:34:25 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 18:34:25 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 18:34:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cXcwYnKK4w/Render', 18:34:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:25 INFO - 'HOME': '/Users/cltbld', 18:34:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:25 INFO - 'LOGNAME': 'cltbld', 18:34:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:25 INFO - 'MOZ_NO_REMOTE': '1', 18:34:25 INFO - 'NO_EM_RESTART': '1', 18:34:25 INFO - 'PAGER': '/bin/cat', 18:34:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:25 INFO - 'PWD': '/builds/slave/test', 18:34:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:25 INFO - 'SHELL': '/bin/bash', 18:34:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdS7eBJWeD/Listeners', 18:34:25 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:34:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:25 INFO - 'USER': 'cltbld', 18:34:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:25 INFO - 'XPC_FLAGS': '0x0', 18:34:25 INFO - 'XPC_SERVICE_NAME': '0', 18:34:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:25 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:34:25 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 18:34:25 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 18:34:25 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 18:34:25 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 18:34:25 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 18:34:25 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 18:34:28 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:34:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:34:28 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:34:28 INFO - Installing collected packages: mozsystemmonitor 18:34:28 INFO - Running setup.py install for mozsystemmonitor 18:34:28 INFO - Successfully installed mozsystemmonitor 18:34:28 INFO - Cleaning up... 18:34:28 INFO - Return code: 0 18:34:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:34:28 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')]} 18:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:28 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')]} 18:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:28 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 0x105118a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105128420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1ca4bd2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fb7e00>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fb2b20>, '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.cXcwYnKK4w/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.jdS7eBJWeD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 18:34:28 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 18:34:28 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 18:34:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cXcwYnKK4w/Render', 18:34:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:28 INFO - 'HOME': '/Users/cltbld', 18:34:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:28 INFO - 'LOGNAME': 'cltbld', 18:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:28 INFO - 'MOZ_NO_REMOTE': '1', 18:34:28 INFO - 'NO_EM_RESTART': '1', 18:34:28 INFO - 'PAGER': '/bin/cat', 18:34:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:28 INFO - 'PWD': '/builds/slave/test', 18:34:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:28 INFO - 'SHELL': '/bin/bash', 18:34:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdS7eBJWeD/Listeners', 18:34:28 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:34:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:28 INFO - 'USER': 'cltbld', 18:34:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:28 INFO - 'XPC_FLAGS': '0x0', 18:34:28 INFO - 'XPC_SERVICE_NAME': '0', 18:34:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:28 INFO - Downloading/unpacking blobuploader==1.2.4 18:34:28 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 18:34:28 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 18:34:28 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 18:34:28 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 18:34:28 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 18:34:28 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 18:34:31 INFO - Downloading blobuploader-1.2.4.tar.gz 18:34:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:34:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:34:31 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 18:34:31 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 18:34:31 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 18:34:31 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 18:34:31 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 18:34:31 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 18:34:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:34:31 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:34:31 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 18:34:31 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 18:34:31 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 18:34:31 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 18:34:31 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 18:34:31 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 18:34:32 INFO - Downloading docopt-0.6.1.tar.gz 18:34:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:34:32 INFO - Installing collected packages: blobuploader, requests, docopt 18:34:32 INFO - Running setup.py install for blobuploader 18:34:32 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:34:32 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:34:32 INFO - Running setup.py install for requests 18:34:32 INFO - Running setup.py install for docopt 18:34:33 INFO - Successfully installed blobuploader requests docopt 18:34:33 INFO - Cleaning up... 18:34:33 INFO - Return code: 0 18:34:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:34: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')]} 18:34:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34: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')]} 18:34:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:33 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 0x105118a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105128420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1ca4bd2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fb7e00>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fb2b20>, '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.cXcwYnKK4w/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.jdS7eBJWeD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 18:34:33 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 18:34:33 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 18:34:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cXcwYnKK4w/Render', 18:34:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:33 INFO - 'HOME': '/Users/cltbld', 18:34:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:33 INFO - 'LOGNAME': 'cltbld', 18:34:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:33 INFO - 'MOZ_NO_REMOTE': '1', 18:34:33 INFO - 'NO_EM_RESTART': '1', 18:34:33 INFO - 'PAGER': '/bin/cat', 18:34:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:33 INFO - 'PWD': '/builds/slave/test', 18:34:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:33 INFO - 'SHELL': '/bin/bash', 18:34:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdS7eBJWeD/Listeners', 18:34:33 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:34:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:33 INFO - 'USER': 'cltbld', 18:34:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:33 INFO - 'XPC_FLAGS': '0x0', 18:34:33 INFO - 'XPC_SERVICE_NAME': '0', 18:34:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:34:33 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-EkgBhn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:34:33 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-auCZtQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:34:33 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-Mj_MIE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:34:33 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-6f61Je-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:34:33 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-Z_K6A0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:34:33 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:34:33 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-3SfyYO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:34:34 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-5IqVt_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:34:34 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-6ONlUU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:34:34 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-f5uC5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:34:34 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-AwW3_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:34:34 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-3zIgD7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:34:34 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-b3ostc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:34:34 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-Zqs3Mk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:34:34 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-coYgy9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:34:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:34:34 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-5pY0an-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:34:35 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-rsBfEN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:34:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:34:35 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-e2kfMS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:34:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:34:35 INFO - Running setup.py install for manifestparser 18:34:35 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:34:35 INFO - Running setup.py install for mozcrash 18:34:35 INFO - Running setup.py install for mozdebug 18:34:35 INFO - Running setup.py install for mozdevice 18:34:35 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:34:35 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:34:35 INFO - Running setup.py install for mozfile 18:34:36 INFO - Running setup.py install for mozhttpd 18:34:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:34:36 INFO - Running setup.py install for mozinfo 18:34:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:34:36 INFO - Running setup.py install for mozInstall 18:34:36 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:34:36 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:34:36 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:34:36 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:34:36 INFO - Running setup.py install for mozleak 18:34:36 INFO - Running setup.py install for mozlog 18:34:36 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:34:36 INFO - Running setup.py install for moznetwork 18:34:36 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:34:36 INFO - Running setup.py install for mozprocess 18:34:37 INFO - Running setup.py install for mozprofile 18:34:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:34:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:34:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:34:37 INFO - Running setup.py install for mozrunner 18:34:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:34:37 INFO - Running setup.py install for mozscreenshot 18:34:37 INFO - Running setup.py install for moztest 18:34:37 INFO - Running setup.py install for mozversion 18:34:37 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:34:37 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:34:37 INFO - Cleaning up... 18:34:37 INFO - Return code: 0 18:34:37 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:34: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')]} 18:34:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34: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')]} 18:34:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:37 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 0x105118a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105128420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1ca4bd2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fb7e00>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fb2b20>, '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.cXcwYnKK4w/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.jdS7eBJWeD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 18:34:37 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 18:34:37 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 18:34:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cXcwYnKK4w/Render', 18:34:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:37 INFO - 'HOME': '/Users/cltbld', 18:34:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:37 INFO - 'LOGNAME': 'cltbld', 18:34:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:37 INFO - 'MOZ_NO_REMOTE': '1', 18:34:37 INFO - 'NO_EM_RESTART': '1', 18:34:37 INFO - 'PAGER': '/bin/cat', 18:34:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:37 INFO - 'PWD': '/builds/slave/test', 18:34:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:37 INFO - 'SHELL': '/bin/bash', 18:34:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdS7eBJWeD/Listeners', 18:34:37 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:34:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:37 INFO - 'USER': 'cltbld', 18:34:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:37 INFO - 'XPC_FLAGS': '0x0', 18:34:37 INFO - 'XPC_SERVICE_NAME': '0', 18:34:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:34:38 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-Wa85ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:34:38 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)) 18:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:34:38 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-hl4LY8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:34:38 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)) 18:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:34:38 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-07qWtK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:34:38 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)) 18:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:34:38 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-pafNdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:34:38 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)) 18:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:34:38 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-of8YSn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:34:38 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)) 18:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:34:38 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-H9Iasz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:34:38 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)) 18:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:34:38 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-lTK9Nj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:34:38 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)) 18:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:34:38 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-PKU8SZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:34:38 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)) 18:34:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:34:38 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-IGYNQ0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:34:39 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)) 18:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:34:39 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-zErc0q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:34:39 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)) 18:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:34:39 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-bA_taY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:34:39 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)) 18:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:34:39 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-12ptWl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:34:39 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)) 18:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:34:39 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-myn_ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:34:39 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)) 18:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:34:39 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-S9OiE2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:34:39 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)) 18:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:34:39 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-7LASHF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:34:39 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)) 18:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:34:39 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-Kukhga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:34:39 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)) 18:34:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:34:39 INFO - Running setup.py (path:/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/pip-4IlSdZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:34:39 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)) 18:34:39 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)) 18:34:39 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)) 18:34:39 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)) 18:34:39 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)) 18:34:39 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)) 18:34:39 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:34:39 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 18:34:39 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 18:34:39 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 18:34:39 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 18:34:39 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 18:34:39 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 18:34:42 INFO - Downloading blessings-1.6.tar.gz 18:34:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:34:42 INFO - Installing collected packages: blessings 18:34:42 INFO - Running setup.py install for blessings 18:34:42 INFO - Successfully installed blessings 18:34:42 INFO - Cleaning up... 18:34:42 INFO - Return code: 0 18:34:42 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:34:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:34:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:34:42 INFO - Reading from file tmpfile_stdout 18:34:42 INFO - Current package versions: 18:34:42 INFO - blessings == 1.6 18:34:42 INFO - blobuploader == 1.2.4 18:34:42 INFO - docopt == 0.6.1 18:34:42 INFO - manifestparser == 1.1 18:34:42 INFO - mozInstall == 1.12 18:34:42 INFO - mozcrash == 0.17 18:34:42 INFO - mozdebug == 0.1 18:34:42 INFO - mozdevice == 0.48 18:34:42 INFO - mozfile == 1.2 18:34:42 INFO - mozhttpd == 0.7 18:34:42 INFO - mozinfo == 0.9 18:34:42 INFO - mozleak == 0.1 18:34:42 INFO - mozlog == 3.1 18:34:42 INFO - moznetwork == 0.27 18:34:42 INFO - mozprocess == 0.22 18:34:42 INFO - mozprofile == 0.28 18:34:42 INFO - mozrunner == 6.11 18:34:42 INFO - mozscreenshot == 0.1 18:34:42 INFO - mozsystemmonitor == 0.0 18:34:42 INFO - moztest == 0.7 18:34:42 INFO - mozversion == 1.4 18:34:42 INFO - psutil == 3.1.1 18:34:42 INFO - requests == 1.2.3 18:34:42 INFO - wsgiref == 0.1.2 18:34:42 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:34: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')]} 18:34:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34: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')]} 18:34:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:42 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 0x105118a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105128420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1ca4bd2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fb7e00>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fb2b20>, '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.cXcwYnKK4w/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.jdS7eBJWeD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 18:34:42 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 18:34:42 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 18:34:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cXcwYnKK4w/Render', 18:34:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:42 INFO - 'HOME': '/Users/cltbld', 18:34:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:42 INFO - 'LOGNAME': 'cltbld', 18:34:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:42 INFO - 'MOZ_NO_REMOTE': '1', 18:34:42 INFO - 'NO_EM_RESTART': '1', 18:34:42 INFO - 'PAGER': '/bin/cat', 18:34:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:42 INFO - 'PWD': '/builds/slave/test', 18:34:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:42 INFO - 'SHELL': '/bin/bash', 18:34:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdS7eBJWeD/Listeners', 18:34:42 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:34:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:42 INFO - 'USER': 'cltbld', 18:34:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:42 INFO - 'XPC_FLAGS': '0x0', 18:34:42 INFO - 'XPC_SERVICE_NAME': '0', 18:34:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:43 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)) 18:34:43 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)) 18:34:43 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)) 18:34:43 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)) 18:34:43 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)) 18:34:43 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)) 18:34:43 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)) 18:34:43 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)) 18:34:43 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)) 18:34:43 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)) 18:34:43 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)) 18:34:43 INFO - Cleaning up... 18:34:43 INFO - Return code: 0 18:34:43 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 18:34:43 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')]} 18:34:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:43 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')]} 18:34:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34:43 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 0x105118a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105128420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1ca4bd2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fb7e00>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fb2b20>, '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.cXcwYnKK4w/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.jdS7eBJWeD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 18:34:43 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 18:34:43 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 18:34:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cXcwYnKK4w/Render', 18:34:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:43 INFO - 'HOME': '/Users/cltbld', 18:34:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:43 INFO - 'LOGNAME': 'cltbld', 18:34:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:43 INFO - 'MOZ_NO_REMOTE': '1', 18:34:43 INFO - 'NO_EM_RESTART': '1', 18:34:43 INFO - 'PAGER': '/bin/cat', 18:34:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:43 INFO - 'PWD': '/builds/slave/test', 18:34:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:43 INFO - 'SHELL': '/bin/bash', 18:34:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdS7eBJWeD/Listeners', 18:34:43 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:34:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:43 INFO - 'USER': 'cltbld', 18:34:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:43 INFO - 'XPC_FLAGS': '0x0', 18:34:43 INFO - 'XPC_SERVICE_NAME': '0', 18:34:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:43 INFO - Downloading/unpacking jsonschema 18:34:43 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 18:34:43 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 18:34:43 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 18:34:43 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 18:34:43 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 18:34:43 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 18:34:45 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 18:34:45 INFO - Downloading/unpacking functools32 (from jsonschema) 18:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:34:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:34:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 18:34:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 18:34:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 18:34:46 INFO - Downloading functools32-3.2.3-2.tar.gz 18:34:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 18:34:46 INFO - warning: no files found matching '*.txt' 18:34:46 INFO - no previously-included directories found matching 'build' 18:34:46 INFO - no previously-included directories found matching 'dist' 18:34:46 INFO - no previously-included directories found matching '.git*' 18:34:46 INFO - Installing collected packages: jsonschema, functools32 18:34:46 INFO - Running setup.py install for functools32 18:34:46 INFO - warning: no files found matching '*.txt' 18:34:46 INFO - no previously-included directories found matching 'build' 18:34:46 INFO - no previously-included directories found matching 'dist' 18:34:46 INFO - no previously-included directories found matching '.git*' 18:34:46 INFO - Successfully installed jsonschema functools32 18:34:46 INFO - Cleaning up... 18:34:46 INFO - Return code: 0 18:34:46 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 18:34: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')]} 18:34:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:34:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34: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')]} 18:34:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:34:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:34: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105118a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105128420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff1ca4bd2c0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104fb7e00>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fb2b20>, '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.cXcwYnKK4w/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.jdS7eBJWeD/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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 18:34: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', 'flake8'] in /builds/slave/test/build 18:34: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 flake8 18:34:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cXcwYnKK4w/Render', 18:34:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:34:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:34:46 INFO - 'HOME': '/Users/cltbld', 18:34:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:34:46 INFO - 'LOGNAME': 'cltbld', 18:34:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:34:46 INFO - 'MOZ_NO_REMOTE': '1', 18:34:46 INFO - 'NO_EM_RESTART': '1', 18:34:46 INFO - 'PAGER': '/bin/cat', 18:34:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:34:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:34:46 INFO - 'PWD': '/builds/slave/test', 18:34:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:34:46 INFO - 'SHELL': '/bin/bash', 18:34:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdS7eBJWeD/Listeners', 18:34:46 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:34:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:34:46 INFO - 'USER': 'cltbld', 18:34:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:34:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:34:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:34:46 INFO - 'XPC_FLAGS': '0x0', 18:34:46 INFO - 'XPC_SERVICE_NAME': '0', 18:34:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:34:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:34:46 INFO - Downloading/unpacking flake8 18:34:46 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 18:34:46 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 18:34:46 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 18:34:46 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 18:34:46 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 18:34:46 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 18:34:49 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 18:34:49 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 18:34:49 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 18:34:49 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 18:34:49 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 18:34:49 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 18:34:49 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 18:34:49 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 18:34:49 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 18:34:49 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 18:34:49 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 18:34:49 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 18:34:49 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 18:34:49 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 18:34:49 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 18:34:49 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 18:34:49 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 18:34:49 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 18:34:49 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 18:34:49 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 18:34:49 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 18:34:49 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 18:34:49 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 18:34:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 18:34:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:34:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:34:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:34:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:34:50 INFO - no previously-included directories found matching 'docs/_build' 18:34:50 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 18:34:50 INFO - Running setup.py install for pep8 18:34:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 18:34:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 18:34:50 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 18:34:50 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 18:34:50 INFO - no previously-included directories found matching 'docs/_build' 18:34:50 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 18:34:50 INFO - Successfully installed flake8 mccabe pyflakes pep8 18:34:50 INFO - Cleaning up... 18:34:50 INFO - Return code: 0 18:34:50 INFO - Running post-action listener: _resource_record_post_action 18:34:50 INFO - Running post-action listener: _start_resource_monitoring 18:34:50 INFO - Starting resource monitoring. 18:34:50 INFO - ##### 18:34:50 INFO - ##### Running install step. 18:34:50 INFO - ##### 18:34:50 INFO - Running pre-action listener: _resource_record_pre_action 18:34:50 INFO - Running main action method: install 18:34:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:34:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:34:51 INFO - Reading from file tmpfile_stdout 18:34:51 INFO - Detecting whether we're running mozinstall >=1.0... 18:34:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:34:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:34:51 INFO - Reading from file tmpfile_stdout 18:34:51 INFO - Output received: 18:34:51 INFO - Usage: mozinstall [options] installer 18:34:51 INFO - Options: 18:34:51 INFO - -h, --help show this help message and exit 18:34:51 INFO - -d DEST, --destination=DEST 18:34:51 INFO - Directory to install application into. [default: 18:34:51 INFO - "/builds/slave/test"] 18:34:51 INFO - --app=APP Application being installed. [default: firefox] 18:34:51 INFO - mkdir: /builds/slave/test/build/application 18:34:51 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'] 18:34:51 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 18:35:25 INFO - Reading from file tmpfile_stdout 18:35:25 INFO - Output received: 18:35:25 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:35:25 INFO - Running post-action listener: _resource_record_post_action 18:35:25 INFO - ##### 18:35:25 INFO - ##### Running run-tests step. 18:35:25 INFO - ##### 18:35:25 INFO - Running pre-action listener: _resource_record_pre_action 18:35:25 INFO - Running main action method: run_tests 18:35:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:35:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:35:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:35:25 INFO - 2016-03-25 18:35:25.331 screenresolution[1930:13728] starting screenresolution argv=screenresolution get 18:35:25 INFO - 2016-03-25 18:35:25.334 screenresolution[1930:13728] Display 0: 1600x1200x32@60 18:35:25 INFO - 2016-03-25 18:35:25.340 screenresolution[1931:13731] starting screenresolution argv=screenresolution list 18:35:25 INFO - Available Modes on Display 0 18:35:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:35:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:35:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:35:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:35:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:35:25 INFO - Intel Iris: 18:35:25 INFO - Chipset Model: Intel Iris 18:35:25 INFO - Type: GPU 18:35:25 INFO - Bus: Built-In 18:35:25 INFO - VRAM (Dynamic, Max): 1536 MB 18:35:25 INFO - Vendor: Intel (0x8086) 18:35:25 INFO - Device ID: 0x0a2e 18:35:25 INFO - Revision ID: 0x0009 18:35:25 INFO - Displays: 18:35:25 INFO - Display: 18:35:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:35:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:35:25 INFO - Display Serial Number: 1600x1200 60 18:35:25 INFO - Main Display: Yes 18:35:25 INFO - Mirror: Off 18:35:25 INFO - Online: Yes 18:35:25 INFO - Rotation: Supported 18:35:25 INFO - Return code: 0 18:35:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:35:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:35:25 INFO - Python 2.7.3 18:35:25 INFO - Return code: 0 18:35:25 INFO - grabbing minidump binary from tooltool 18:35:25 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')]} 18:35:25 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 0x104fb7e00>, '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 0x104de0db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104fb2b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:35:25 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 18:35:25 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 18:35:25 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:35:25 INFO - Return code: 0 18:35:25 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:35:25 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:35:25 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:35:25 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:35:25 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:35:25 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 18:35:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 18:35:26 INFO - Return code: 0 18:35:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0130', '--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 18:35:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0130 --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 18:35:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cXcwYnKK4w/Render', 18:35:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:35:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:35:26 INFO - 'HOME': '/Users/cltbld', 18:35:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:35:26 INFO - 'LOGNAME': 'cltbld', 18:35:26 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:35:26 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:35:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:35:26 INFO - 'MOZ_NO_REMOTE': '1', 18:35:26 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:35:26 INFO - 'NO_EM_RESTART': '1', 18:35:26 INFO - 'PAGER': '/bin/cat', 18:35:26 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:35:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:35:26 INFO - 'PWD': '/builds/slave/test', 18:35:26 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:35:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:35:26 INFO - 'SHELL': '/bin/bash', 18:35:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jdS7eBJWeD/Listeners', 18:35:26 INFO - 'TMPDIR': '/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/', 18:35:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:35:26 INFO - 'USER': 'cltbld', 18:35:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:35:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:35:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:35:26 INFO - 'XPC_FLAGS': '0x0', 18:35:26 INFO - 'XPC_SERVICE_NAME': '0', 18:35:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 18:35:26 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0130', '--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 18:35:27 INFO - mozversion application_buildid: 20160325165039 18:35:27 INFO - mozversion application_changeset: 070628989f86334dfd35ae04c5f5151bdb8589a3 18:35:27 INFO - mozversion application_display_name: Nightly 18:35:27 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:35:27 INFO - mozversion application_name: Firefox 18:35:27 INFO - mozversion application_remotingname: firefox 18:35:27 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 18:35:27 INFO - mozversion application_vendor: Mozilla 18:35:27 INFO - mozversion application_version: 48.0a1 18:35:27 INFO - mozversion platform_buildid: 20160325165039 18:35:27 INFO - mozversion platform_changeset: 070628989f86334dfd35ae04c5f5151bdb8589a3 18:35:27 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 18:35:27 INFO - mozversion platform_version: 48.0a1 18:35:27 INFO - using testdate: 1458956127 18:35:27 INFO - actual date: 1458956127 18:35:27 INFO - starting webserver on 'localhost:49665' 18:35:27 INFO - SUITE-START | Running 2 tests 18:35:27 INFO - TEST-START | dromaeo_css 18:35:27 INFO - operating with platform_type : mac_ 18:35:27 INFO - Initialising browser for dromaeo_css test... 18:35:27 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpoSa2x1/profile http://localhost:49665/getInfo.html) 18:35:29 INFO - PROCESS | 1949 | __metrics Screen width/height:1600/1200 18:35:29 INFO - PROCESS | 1949 | colorDepth:24 18:35:29 INFO - PROCESS | 1949 | Browser inner width/height: 1024/689 18:35:29 INFO - PROCESS | 1949 | __metrics 18:35:29 INFO - PROCESS | 1949 | 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" 18:35:29 ERROR - PROCESS | 1949 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:35:30 INFO - TEST-INFO | 1949: exit 0 18:35:30 INFO - Browser initialized. 18:35:30 INFO - Running cycle 1/1 for dromaeo_css test... 18:35:30 INFO - TEST-INFO | started process 1952 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpoSa2x1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:35:42 INFO - PROCESS | 1952 | RSS: Main: 244051968 18:35:42 INFO - PROCESS | 1952 | 18:36:33 INFO - PROCESS | 1952 | 1458956193488 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] 18:38:43 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49665/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49665/tests/dromaeo/cssquery-ext.html) 18:38:44 INFO - PROCESS | 1952 | RSS: Main: 415121408 18:38:44 INFO - PROCESS | 1952 | 18:41:47 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49665/tests/dromaeo/cssquery-ext.html (next: http://localhost:49665/tests/dromaeo/cssquery-jquery.html) 18:41:48 INFO - PROCESS | 1952 | RSS: Main: 380436480 18:41:48 INFO - PROCESS | 1952 | 18:44:50 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49665/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49665/tests/dromaeo/cssquery-mootools.html) 18:44:50 INFO - PROCESS | 1952 | RSS: Main: 376406016 18:44:50 INFO - PROCESS | 1952 | 18:47:53 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49665/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49665/tests/dromaeo/cssquery-prototype.html) 18:47:53 INFO - PROCESS | 1952 | RSS: Main: 333705216 18:47:53 INFO - PROCESS | 1952 | 18:50:56 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49665/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49665/tests/dromaeo/cssquery-yui.html) 18:50:57 INFO - PROCESS | 1952 | RSS: Main: 336384000 18:50:57 INFO - PROCESS | 1952 | 18:53:59 INFO - PROCESS | 1952 | Cycle 1(1): loaded http://localhost:49665/tests/dromaeo/cssquery-yui.html (next: http://localhost:49665/tests/dromaeo/cssquery-dojo.html) 18:54:00 INFO - PROCESS | 1952 | RSS: Main: 400396288 18:54:00 INFO - PROCESS | 1952 | 18:54:00 INFO - PROCESS | 1952 | __start_tp_report 18:54:00 INFO - PROCESS | 1952 | _x_x_mozilla_page_load 18:54:00 INFO - PROCESS | 1952 | _x_x_mozilla_page_load_details 18:54:00 INFO - PROCESS | 1952 | |i|pagename|runs| 18:54:00 INFO - PROCESS | 1952 | |0;dojo.html;3420.794752314861;3478.9826050869756;3499.300139972006;3524.9471257931127;3567.5005499230097;4731.29030645403;5629;5632.3804381518;5676.318841738997;5703.714814259291;4780;5628.493435590796;5717.571182161334;5719.4566516181;5720.084786434171;5159.458256883029;5160.277561141434;5194.194899790538;5209.973950130263;5276.894462110775;5273.156294992802;5277.6305658603915;5285.947140528603;5289.629725919187;5290.153575427932;5186.0665080285535;5233.058049551079;5236.528712415882;5262.342207224097;5278.076336641073;5268.973655131719;5303.575713942875;5323.4357376739645;5323.840284791462;5331.5201631853315;5111.207762796773;5129.179331306973;5139.408967968694;5228.215767634847;5244.947550524484;5638.661680299195;5659.971700141514;5667.518260947824;5680.6591604503865;5753.050746626802;6278.843028924268;6284.497240220771;6287.591306565105;6288.87422251557;6289.308176100625;6117.5717699761035;6131.662758548278;6234.781782637586;6346.921023425983;6352.237731472207;5818.534517238653;5825;5830.591858569859;5832.416758324133;5852.385499522574;6339.809805705836;6366.331535188831;6367.331430199855;6372.808815735535;6374.872502550016;5817.0983497557945;6059.33347331802;6118.611691595641;6146.969265153735;6147.139400483936;6200.286966998763;6222.81331560054;6273;6276.027215781562;6293.2762732285455;6145.477634401037;6182.783602573888;6203.875922481525;6204.100405441186;6206.038064100072;5193.740312984336;6094.329623741385;6115.970584430425;6164.537659675542;6276.278228003746;4880.585150262196;4884.633652476078;4887.731174785421;4898.951010489849;4920.778564964585;4377.890552736207;4384.232759267115;4386.8025938832825;4389.934150987738;4431.711938723973;5624.97187514068;5710.885782284331;5714.485696287354;5719.056355701263;5724.084146536534;6135.159297383386;6198.349173336735;6237.563370564017;6237.812865614039;6261.342559031327;5623.5220006299105;5692.345380281321;5706.115552089433;5708.771649133988;5808.79669211584;5345.465453454701;5383.380911195262;5395.541378982752;5420;5427.891442171213;6349.238091429058;6349.777757778455;6353.968230158912;6357.7139028742895;6366.554341196164;6187.381261873777;6190.907136392868;6324.367563243639;6324.715387807468;6325.652089135142;6284.591501552384;6349.904751428639;6358.982562789932;6361.459275961595;6362.04569314588;6115.510759139347;6135.11040899076;6141.07883817431;6142.815715528542;6180.258368995749;6109.131392048963;6235.625862448268;6274.278457977391;6284.308726040041;6299.905501417574;6035.668038257938;6048.546359023003;6051.576389652682;6053.878922421615;6082.878342433038;5967.641941483351;6063.605865618721;6068.575199736153;6083.969580152071;6087.908681369694;5874.676892770768;5908.852278693067;5914.053751399755;5914.7338369774325;5921.733521991435;5927.199828023162;5971.044632858721;5981.671008094422;5990.9700451497465;6009.399060093956;5965.194698715618;5969.641821490724;5970.462658360769;5984.222051133324;5986.102084687332 18:54:00 INFO - PROCESS | 1952 | |1;ext.html;447.2173696031944;510.4844107451473;544.686805087075;628.864794069275;639.9552031357804;26711;29964.850175749118;29978.85010574947;30115;38125;29617.85191074047;41424.79287603558;41471.75584732455;41491;41627;9345.06549345067;9591.232701383873;9618.663346782863;9623.663171788989;9633.229341652686;9408.012158723339;9539.427634341928;9548.570314335837;9552.474613896233;9578.760530986747;9464.763380915498;9679.758006049835;9694.66068687596;9701.175400091;9725.465099419565;9590.328676992613;9659.951700241454;9669.758256043584;9675.903240967571;9680.419174849532;9500.477473738942;9610.183134433582;9635.614575416976;9658.903410965871;9668.371555848847;39723.20553588912;39956.40065399021;39966.40050399247;39975.40036899449;39995.600043999475;3171.9207019824457;3231.4991176367703;3268.4607039838397;3353.111425472252;3672.4307732301536;27443.451130977268;27593.034243801572;27626.447471050466;28051.737671804818;28233.858830705714;2729;2761.1716485054403;2784.763295119917;2860.6281183446226;2905.0102264679963;491833;494540;496165;496196;496464.5176774129;67780.66109669518;68169;68623.65688171527;68758;68786;72351.6382418095;72986.63506682539;73982.6300868503;74171;74338.14154646177;16352.100634465218;16531.752023719655;16543.420980265873;16561.08914009741;16593.751093733605;11495.310281383145;11884.286942783461;12496.375181240901;12571.748565028649;12590.748185036247;20977.16091356359;21230.36308910735;21314.78685213128;21316.04077816502;21332.680009799864;7658.234176582298;7714.382849372037;8814.86777698335;9026.743314171457;9030.503322317336;882.342654722236;947.7441090905555;1028.8250997330472;1053.7049626104704;1129.4352823588206;28552.428951421272;28818.828593635157;29100;29108;29401;1030.5208078243652;1095.6767753512574;1110.7889500994786;1183.526589364261;1220.1093201962617;14634.634134146732;14720.631984200481;14815.777763333559;14984.850151498564;15067.698646027018;528538;530168;536066;536909;539375;58649;59323.40676593179;59408;59408.40591594029;59517.40482595205;1154.4285578638628;1435.2967046147312;1453.9127652340894;1461.3058797071305;1488.2038109611522;27730;28275.717242827308;28358.29104272327;28783.8560807203;29245.85377073101;46368;47011.52988470208;47284.29073563968;47290.29064563965;47327.81680458016;371397.1430142832;374039;374243;374737.1263143667;374967;28042.579361310003;32198.35603287968;32850.671493285714;33278;33388.66611333856;40638.79680601578;41279.7936010318;41477.792611036755;41818.37272440977;42268.577314226466;27521.724782751917;34448.138796530286;34721.9583412498;35162.64837351696;35442.291154177285;33910.66089339075;34176.48735269023;34385.48421773625;34605.9236445814;34847.825760871034;34846.303073938885;35166.82416587901;35703;35996;36755;30522.389552209275;31073.223169420944;31082.844585776926;31140.065798026095;31147.84426077855;23393.527730816033;23631.409214769767;23840.284791456284;23937.880310598335;23983.880080599487 18:54:00 INFO - PROCESS | 1952 | |2;jquery.html;306.3597082098414;354.6028448138084;360.33166439385633;361.9113317237276;367.60666087286614;15146;18897;19326.487556617638;20104.798952010475;20127.59744805103;18775;19703.31038413656;19928.103235354407;19960.700589491134;19966.900165499188;5599.160125981095;5886.705664716747;5933.317668468138;5982.670953097578;5984.162217289561;4208.915821683579;4405.713628614129;4446.333050042487;4452.421185245914;5824.126381042856;6265.091561723548;6539.836504087412;6540.607563546178;6541.967290163567;6554.41010309072;6231.345708700589;6365.681715914186;6386.999999999976;6396.104545363606;6411.6153030818305;3629.4555816627453;5354.464553544653;5496.0931446311315;5527.336719593634;5536.335639723259;24218.515629687485;24291;24609.892554834896;24802.131925382706;24842.751572484405;2147.527543940331;2157.7410710714817;2254;2283.7259528856644;2300.5053913408697;14257.572272831832;14439.566812995521;14733.968622196451;14916.105033698013;14926.552203433914;1695.211726547149;1716.2877405876545;1744.110503643151;1773.5388798912247;1794.7397627343962;84592.57703711504;89296.42814287421;101940;103443.93112137716;103549.48225258825;9767.706968790948;10316.793664126826;10672.946635266773;10924.344539327665;11174.497147628375;13351.73296534064;13421.664458388423;13480.393382297623;13487.865121348857;13489.12320699171;6991.300869912968;7461.694203514472;8121.106678265386;8311.090384100076;8439.620217090123;8090.190980901981;8517.44636598619;8527.872081918777;8612.8708069379;8629;4343.67422443318;4410.977945110254;4418.7127836690515;4441.800713807254;4463.66522510813;1728.8444040036456;1781.358710864088;1790.2838864454322;1794.255384015645;1816.7910690270523;789.9960500197577;910.5113140015989;915.4827522449928;986.8667729856378;999.4652860719481;19049;19815.12680661296;19859.900700496404;19982;20147.597048058957;945.2060269373759;945.7210123013728;967.3857100740939;1005.9789313846452;1044.5821671331375;8678.86981695275;10748;10972.945135274273;10985.39580323074;11006.009459148716;510871;519402;520786;630390.8480457568;632383;106758.96903511761;112274.87725122807;115441;116851;117694.41152794352;961.5721004153085;1012.4077414712476;1024.626011505795;1058.6136060337922;1067.3969207397795;15864.44474443389;18333.083345832387;18405.723914141032;18424.078796059875;18608.06959651985;48656.2701559484;49043.01913961772;49393;50689.74655126701;50801.49198507968;70677;71892;72129.6393518029;72259.63870180615;72370;7593.278638529331;7597.772066838003;7772.261635144652;7798.298153166243;7882.132965373919;9127.908720912706;11607.187496875138;11981.76036479283;12274.140810143204;12288.938555307524;10361.378317300685;10583.364998100138;10730.356178629307;10780.622678206226;10966.287191332538;10199.592016319264;10398.324108932895;10562.788744225227;10632.574697012033;10825;10765.30025548337;10909.236353455182;11028.889711102785;11212.775744485229;11237.438128093727;6435.967820160869;7728.033995750531;7759.146493885555;7829.060512738508;7880.05439347282;9632.95183524078;10729.141668666643;10942.398168100832;10997.450127493754;11019.393933333424 18:54:00 INFO - PROCESS | 1952 | |3;mootools.html;1463.8536146385356;1600.0239853689247;1636.1982628512028;1901.2585091814194;2018.4852862520065;7975.202479752029;8201.548914809682;8203.54880481574;8206.876896846545;8212.630431630576;8086.312663423601;8455.281301089415;8624.741257762276;8656.610452529636;8664.783380415493;2417.6494408310787;2497.8126640501946;2498.912538061168;2500.0124950644486;2500.949981000388;2103.3900168951063;2167.945801354963;2407.9759202408013;2424.7938925191293;2492.663490428787;2421.455172586163;2456.349067497115;2459;2462.729099799021;2466.050570530341;2408.0488207158164;2464.4085419499193;2465.9642949961058;2466.235467005225;2469.77772000519;2332.2187067332466;2344.355302291883;2381.9047238110456;2385.093664407514;2386.4391867911027;8589.527575983318;8657.393982421234;8679.826403471896;8688;8865.955670221672;5372.7045012524295;5532.419095994943;5534.723263836792;5569.359523654751;5578.832635020955;3462.5498685170764;3462.9653703463146;3557.1107223194203;3618.7285953553323;3618.981905090484;1068.7167900506372;1085.3596378136858;1613.6127329440967;1649.983500164995;1668.3410053029106;12020.69948251292;12072.094592905567;12073.335966521838;12077.758444831143;12184.51261949521;4145.129522800185;4604.171249175113;4605.861824145281;4745.501722319107;4791.904161916742;9436.339456237998;9457.716268511957;9459.101385368516;9460.148586627236;9461.479618621042;5484.698341591171;5491.450854914477;5493.615446918758;5501.862453438696;5502.972485137549;5014.373203349582;5109.693418394908;5113.386393632788;5116.641835071509;5118.59051275897;3658.9817050914576;3664.706823454117;3667.6882464990776;3713.517242758478;3713.721470889694;1122.2537012886503;1153.948072336747;1194.635636130971;1204.3857632607433;1211.8788121187988;1266.4807428954268;1332.253937794838;1358.2393859438746;1388.4862600837553;1424.017427974694;8215.260626543639;8377.120402357665;8388.245057944814;8395.32837373021;8409.41134120618;1060.4273692206277;1110.744528758374;1195.2768575011992;1215.2040413529153;1218.4577862851124;6336.841578960563;6343.5876668016435;6450.967745161244;6451.064595633607;6458.644774537352;9216.447013179231;10507.894921050845;10992.560297588167;11068.833967490495;11125.943035411623;10811.78376432467;10858.185636077325;10887.129029677606;10968.725781855357;10998;8442.451240669337;8563.88669472977;8582.828343433097;8620.758602763326;8644.654213831376;7758.495697779626;7983.281504664608;8035.879461807961;8069.919300807152;8126.106128325761;9513.952430237805;9756.707298781048;9897.158741507052;9906.900930990598;10050.447225402673;9902.950485247527;10126.645567405105;10163.034511721375;10282.280240383101;10293.43386113771;6671.532992690465;7027.6837542309695;7116.46626503004;7214.134303883568;7219.747308844166;7426.628668566658;8349.499030058216;8402.11777763326;8447.408681392244;8457.02744184402;6591.835204119743;7502.699892004477;7508.924910750822;7535.8116047099265;7701.075870895304;7308.30571095745;7470.140933792466;7497.325240728361;7523.7366692165515;7528.698852045857;7762.61186940662;7881.684732610632;7892.1318654949055;7899.921000789918;7902.723404680809;7037;7148.892766608609;7155.177154627285;7161.606111663908;7252.129744430491;7291.489595728248;7360.411167106511;7364.594947277951;7372.668229929774;7379.667914943733 18:54:00 INFO - PROCESS | 1952 | |4;prototype.html;323.71836502243053;328.5712145649927;333.5613668026546;335.2774770369853;337.2513021093174;5455.399906010346;6595.373439523243;6624.072629831821;6643.833904152399;6651.501137414702;6592.80221593353;6606.867862642756;6628.072069910217;6637.004449332602;6660.500462465322;4681.297805329194;4803.61571074315;4808.278758186265;4921.818763496753;4963.280324352967;3961.227560625679;4913.845246367101;4957.256411538262;4962.305277261186;4985.775640096204;4878.585320247783;4907.2148456247005;4915.090708218973;4926.753662316888;4928.23612340086;4638.884027899296;4705.929411058837;4762.071396077767;4770.666053376265;4851.878703032417;4135.048938744106;4138.296489596745;4139.544650088488;4153.792310384499;4159.83360665573;5622.409646987048;6093.360197179321;6312.179416675803;6358.77744278948;6403.8399040023905;5731.713414329267;5741.19623252745;5751.626144300607;5753.741081651336;5785.681787501686;6746.359095885932;6992.370686638176;7006.684699188549;7008.808502554578;7010.649467526654;4691.577758001797;4702;4708.976455117737;4718.811247550094;4722.574968252839;6286.182796236506;7234.60209688467;7419.10970683516;7425.925740742631;7445.813854653623;4767.976160119247;4774.188387974053;4774.785134668949;4781.474037855833;4783.210770222944;4833.830815921426;4848.854534363974;4850.345203397566;4851.151048566487;4854.514548545118;5742.598018138774;5750.079987202112;5761.567882408836;5764.13537969308;5775.8556036099435;6798.558093723892;7048.330408611174;7052.858942821114;7059.2234854166;7085.775971932758;1395.6441107517721;1681.957951051209;1689.2398420710483;1693.3480609965252;1693.4242357598475;1085.625459216569;1095.7260684828793;1109.2180013090751;1110.816715241976;1118.7818375416716;6398.5521013528605;6414.61512309263;6580.539362244693;6632.071509988606;6646.102776125258;7478;7478;7482;7482.925170748332;7486.700531978769;6642.701078451385;6666.766663166766;6691.799246022627;6697.564658297195;6699.430548403343;3864.903377415531;3899.29812633723;3901.492805935267;3902.941455878164;3922.254771593445;7447.316710415512;7664.233576642403;7666.8849967250535;7670.194629563927;7713.7685869424;6181.660008699565;7503.212162722944;7539.246075392417;7573.318401343795;7577.810554736066;7631;7640.656170472454;7660.655270512729;7673.232676732394;7693.153753087156;6042.335343112166;7274.599897005715;7326.890096648661;7339.449541284318;7344.375728063174;6964.477664175106;7260.891086633599;7265.019222405119;7297.708091676273;7319.560826350223;7683.538987660758;7757.7672669819995;7778.338841198335;7782.066152061789;7799.727009554638;4186.83252669902;4467.776611169364;4612.285095810154;4668.626509879134;4668.719876807402;7343.118825740731;7367.484276100621;7368.078990126234;7369.115706115301;7382.335589796944;6776.186857577122;7061.329173728487;7110.5022648414115;7110.6089165094345;7118.85762284741;5766.711664416678;7090.290970902868;7106.182788979334;7110.857782844418;7156.821079473055;6968.895466567904;6973.302669732986;6979.1973922999505;6980.267071957372;6988.301169882971;6914.239433662394;7121.430285577245;7123.857522849617;7124.821879453055;7135.89393643986;6668.933310666831;6763.5941843489545;6893.551919125241;6969.372756451944;6986.476014298846 18:54:00 INFO - PROCESS | 1952 | |5;yui.html;727.2436665867498;754.6453167011503;759.8252401947552;771.8340556780298;775.5269285735702;14740.557783266506;14927.552173434815;14935.551933442;14949.028313159637;14979.625509362271;13843.30783460828;13848.723025539482;13905.860941390583;13925.37335819888;13926.373313200906;720.0135813934917;720.5100531638484;878.846201914664;880.744584070622;908.7728067983004;903.2999425445266;904.1636486250225;913.7258822353301;914.3188324698109;916.2669864108686;858.8582883824162;912.7854954085784;961.0581630002602;969.5152423788106;970.7573106723319;762.3558093411059;934.654177954158;958.2238386906628;960.1071003966308;961.5576834656067;711.2531841566387;712.0245263988318;712.1383126417041;716;716.1978583985968;14296.714065718628;14461.20463374514;14531.346089426;14548.345324460424;14549.636259093608;12386.938065309705;12425.75148497034;12624.55814046504;12681.619551413472;12685.809712854314;9878.209743220597;9947.303688741791;9960.252981026451;10000.449975251358;10288.382697038202;3446.1212390840174;3480.617132115465;3491.284286721216;3520.5951315598522;3595.8381872815526;63600;79275.60362198151;79703;81379.18620813775;81418;9160.358774885828;9239.907600923905;9604;9617.807643847224;9693.903060969442;18448.446546603624;22150.33548993533;22161.33515994523;22192.55614887693;22196.667049994263;6373.458256048195;7272.854542909112;7395.038644976226;7403.703851845974;7624.085109786861;3915.5497117831815;3972.7219094663674;3976.4234186042863;3997;3999.9800000999808;3610.4223324268514;3670.5778835433734;3679.2273622539565;3680.061584296041;3687.668109870071;616.1004932798165;631.8894193516209;634.403660559073;639.0988705924624;641.2785616181795;581.183437270627;604.0637012630406;606.2391698418456;607.1863702638485;609.5763444406184;8057.556834374049;8066.072401673765;8140.389470789596;8159.551224682581;8445.57772111392;536.1903525676179;572.6220694341714;593.2613895699795;602.9849253768691;607.6809674920702;3777.6788972937607;3802.334591446486;3810.028442747082;3851.768893866377;3952.2490726761825;95095;95512.04487955032;96936.51531742296;97038;97855;77922;77988;77998.6100069496;79269.60365198136;80388;69237.61524769476;69479.65260173767;69579;69666.65166674236;70976.93534596985;6538.8365290868105;7803.453758236869;7838.412119090977;7933.3653307736395;7946.40401969843;50437.747811262176;50973;51367;51425.7428712854;53069.73465132649;49098.75450622724;61966;66067;70002;71776.64111679408;10128.139108175888;10298.409112303516;10375.584976600852;10401.895981040396;10587.258891877495;9714.708558743248;10788.460576971276;10866.728331791768;10884.619038333936;11051.72370690739;9997.450140242065;10241.539130738985;10252.948735256276;10459.843102353623;10582.576696932036;9403.576839042124;10560.630377936735;10825.67522974312;10954.452277386259;11162.274452160584;10865.782953542783;10873.161353779971;11061.400570866;11212.14525117515;11214.83177752318;9208.861867072133;9234.445933244027;9317.301202409983;9414.717558473258;9758.283784995285;8912.777180570538;9026;9027.121174421498;9404.764880878032;9460.526973651153 18:54:00 INFO - PROCESS | 1952 | __end_tp_report 18:54:00 INFO - PROCESS | 1952 | __start_cc_report 18:54:00 INFO - PROCESS | 1952 | _x_x_mozilla_cycle_collect,1579 18:54:00 INFO - PROCESS | 1952 | __end_cc_report 18:54:00 INFO - PROCESS | 1952 | __startTimestamp1458957240054__endTimestamp 18:54:00 INFO - PROCESS | 1952 | 18:54:00 INFO - PROCESS | 1952 | ------- Summary: start ------- 18:54:00 INFO - PROCESS | 1952 | Number of tests: 6 18:54:00 INFO - PROCESS | 1952 | 18:54:00 INFO - PROCESS | 1952 | [#0] dojo.html Cycles:165 Average:5732.73 Median:5927.20 stddev:632.10 (10.7%) stddev-sans-first:607.46 18:54:00 INFO - PROCESS | 1952 | Values: 3420.8 3479.0 3499.3 3524.9 3567.5 4731.3 5629.0 5632.4 5676.3 5703.7 4780.0 5628.5 5717.6 5719.5 5720.1 5159.5 5160.3 5194.2 5210.0 5276.9 5273.2 5277.6 5285.9 5289.6 5290.2 5186.1 5233.1 5236.5 5262.3 5278.1 5269.0 5303.6 5323.4 5323.8 5331.5 5111.2 5129.2 5139.4 5228.2 5244.9 5638.7 5660.0 5667.5 5680.7 5753.1 6278.8 6284.5 6287.6 6288.9 6289.3 6117.6 6131.7 6234.8 6346.9 6352.2 5818.5 5825.0 5830.6 5832.4 5852.4 6339.8 6366.3 6367.3 6372.8 6374.9 5817.1 6059.3 6118.6 6147.0 6147.1 6200.3 6222.8 6273.0 6276.0 6293.3 6145.5 6182.8 6203.9 6204.1 6206.0 5193.7 6094.3 6116.0 6164.5 6276.3 4880.6 4884.6 4887.7 4899.0 4920.8 4377.9 4384.2 4386.8 4389.9 4431.7 5625.0 5710.9 5714.5 5719.1 5724.1 6135.2 6198.3 6237.6 6237.8 6261.3 5623.5 5692.3 5706.1 5708.8 5808.8 5345.5 5383.4 5395.5 5420.0 5427.9 6349.2 6349.8 6354.0 6357.7 6366.6 6187.4 6190.9 6324.4 6324.7 6325.7 6284.6 6349.9 6359.0 6361.5 6362.0 6115.5 6135.1 6141.1 6142.8 6180.3 6109.1 6235.6 6274.3 6284.3 6299.9 6035.7 6048.5 6051.6 6053.9 6082.9 5967.6 6063.6 6068.6 6084.0 6087.9 5874.7 5908.9 5914.1 5914.7 5921.7 5927.2 5971.0 5981.7 5991.0 6009.4 5965.2 5969.6 5970.5 5984.2 5986.1 18:54:00 INFO - PROCESS | 1952 | 18:54:00 INFO - PROCESS | 1952 | [#1] ext.html Cycles:180 Average:61387.92 Median:19834.22 stddev:125789.21 (634.2%) stddev-sans-first:126058.87 18:54:00 INFO - PROCESS | 1952 | Values: 447.2 510.5 544.7 628.9 640.0 26711.0 29964.9 29978.9 30115.0 38125.0 29617.9 41424.8 41471.8 41491.0 41627.0 9345.1 9591.2 9618.7 9623.7 9633.2 9408.0 9539.4 9548.6 9552.5 9578.8 9464.8 9679.8 9694.7 9701.2 9725.5 9590.3 9660.0 9669.8 9675.9 9680.4 9500.5 9610.2 9635.6 9658.9 9668.4 39723.2 39956.4 39966.4 39975.4 39995.6 3171.9 3231.5 3268.5 3353.1 3672.4 27443.5 27593.0 27626.4 28051.7 28233.9 2729.0 2761.2 2784.8 2860.6 2905.0 491833.0 494540.0 496165.0 496196.0 496464.5 67780.7 68169.0 68623.7 68758.0 68786.0 72351.6 72986.6 73982.6 74171.0 74338.1 16352.1 16531.8 16543.4 16561.1 16593.8 11495.3 11884.3 12496.4 12571.7 12590.7 20977.2 21230.4 21314.8 21316.0 21332.7 7658.2 7714.4 8814.9 9026.7 9030.5 882.3 947.7 1028.8 1053.7 1129.4 28552.4 28818.8 29100.0 29108.0 29401.0 1030.5 1095.7 1110.8 1183.5 1220.1 14634.6 14720.6 14815.8 14984.9 15067.7 528538.0 530168.0 536066.0 536909.0 539375.0 58649.0 59323.4 59408.0 59408.4 59517.4 1154.4 1435.3 1453.9 1461.3 1488.2 27730.0 28275.7 28358.3 28783.9 29245.9 46368.0 47011.5 47284.3 47290.3 47327.8 371397.1 374039.0 374243.0 374737.1 374967.0 28042.6 32198.4 32850.7 33278.0 33388.7 40638.8 41279.8 41477.8 41818.4 42268.6 27521.7 34448.1 34722.0 35162.6 35442.3 33910.7 34176.5 34385.5 34605.9 34847.8 34846.3 35166.8 35703.0 35996.0 36755.0 30522.4 31073.2 31082.8 31140.1 31147.8 23393.5 23631.4 23840.3 23937.9 23983.9 18:54:00 INFO - PROCESS | 1952 | 18:54:00 INFO - PROCESS | 1952 | [#2] jquery.html Cycles:180 Average:32566.93 Median:24254.76 stddev:93860.16 (387.0%) stddev-sans-first:94092.21 18:54:00 INFO - PROCESS | 1952 | Values: 306.4 354.6 360.3 361.9 367.6 15146.0 18897.0 19326.5 20104.8 20127.6 18775.0 19703.3 19928.1 19960.7 19966.9 5599.2 5886.7 5933.3 5982.7 5984.2 4208.9 4405.7 4446.3 4452.4 5824.1 6265.1 6539.8 6540.6 6542.0 6554.4 6231.3 6365.7 6387.0 6396.1 6411.6 3629.5 5354.5 5496.1 5527.3 5536.3 24218.5 24291.0 24609.9 24802.1 24842.8 2147.5 2157.7 2254.0 2283.7 2300.5 14257.6 14439.6 14734.0 14916.1 14926.6 1695.2 1716.3 1744.1 1773.5 1794.7 84592.6 89296.4 101940.0 103443.9 103549.5 9767.7 10316.8 10672.9 10924.3 11174.5 13351.7 13421.7 13480.4 13487.9 13489.1 6991.3 7461.7 8121.1 8311.1 8439.6 8090.2 8517.4 8527.9 8612.9 8629.0 4343.7 4411.0 4418.7 4441.8 4463.7 1728.8 1781.4 1790.3 1794.3 1816.8 790.0 910.5 915.5 986.9 999.5 19049.0 19815.1 19859.9 19982.0 20147.6 945.2 945.7 967.4 1006.0 1044.6 8678.9 10748.0 10972.9 10985.4 11006.0 510871.0 519402.0 520786.0 630390.8 632383.0 106759.0 112274.9 115441.0 116851.0 117694.4 961.6 1012.4 1024.6 1058.6 1067.4 15864.4 18333.1 18405.7 18424.1 18608.1 48656.3 49043.0 49393.0 50689.7 50801.5 70677.0 71892.0 72129.6 72259.6 72370.0 7593.3 7597.8 7772.3 7798.3 7882.1 9127.9 11607.2 11981.8 12274.1 12288.9 10361.4 10583.4 10730.4 10780.6 10966.3 10199.6 10398.3 10562.8 10632.6 10825.0 10765.3 10909.2 11028.9 11212.8 11237.4 6436.0 7728.0 7759.1 7829.1 7880.1 9633.0 10729.1 10942.4 10997.5 11019.4 18:54:00 INFO - PROCESS | 1952 | 18:54:00 INFO - PROCESS | 1952 | [#3] mootools.html Cycles:180 Average:6082.95 Median:5488.07 stddev:3191.45 (58.2%) stddev-sans-first:3181.51 18:54:00 INFO - PROCESS | 1952 | Values: 1463.9 1600.0 1636.2 1901.3 2018.5 7975.2 8201.5 8203.5 8206.9 8212.6 8086.3 8455.3 8624.7 8656.6 8664.8 2417.6 2497.8 2498.9 2500.0 2500.9 2103.4 2167.9 2408.0 2424.8 2492.7 2421.5 2456.3 2459.0 2462.7 2466.1 2408.0 2464.4 2466.0 2466.2 2469.8 2332.2 2344.4 2381.9 2385.1 2386.4 8589.5 8657.4 8679.8 8688.0 8866.0 5372.7 5532.4 5534.7 5569.4 5578.8 3462.5 3463.0 3557.1 3618.7 3619.0 1068.7 1085.4 1613.6 1650.0 1668.3 12020.7 12072.1 12073.3 12077.8 12184.5 4145.1 4604.2 4605.9 4745.5 4791.9 9436.3 9457.7 9459.1 9460.1 9461.5 5484.7 5491.5 5493.6 5501.9 5503.0 5014.4 5109.7 5113.4 5116.6 5118.6 3659.0 3664.7 3667.7 3713.5 3713.7 1122.3 1153.9 1194.6 1204.4 1211.9 1266.5 1332.3 1358.2 1388.5 1424.0 8215.3 8377.1 8388.2 8395.3 8409.4 1060.4 1110.7 1195.3 1215.2 1218.5 6336.8 6343.6 6451.0 6451.1 6458.6 9216.4 10507.9 10992.6 11068.8 11125.9 10811.8 10858.2 10887.1 10968.7 10998.0 8442.5 8563.9 8582.8 8620.8 8644.7 7758.5 7983.3 8035.9 8069.9 8126.1 9514.0 9756.7 9897.2 9906.9 10050.4 9903.0 10126.6 10163.0 10282.3 10293.4 6671.5 7027.7 7116.5 7214.1 7219.7 7426.6 8349.5 8402.1 8447.4 8457.0 6591.8 7502.7 7508.9 7535.8 7701.1 7308.3 7470.1 7497.3 7523.7 7528.7 7762.6 7881.7 7892.1 7899.9 7902.7 7037.0 7148.9 7155.2 7161.6 7252.1 7291.5 7360.4 7364.6 7372.7 7379.7 18:54:00 INFO - PROCESS | 1952 | 18:54:00 INFO - PROCESS | 1952 | [#4] prototype.html Cycles:180 Average:5791.72 Median:6615.47 stddev:1843.82 (27.9%) stddev-sans-first:1802.74 18:54:00 INFO - PROCESS | 1952 | Values: 323.7 328.6 333.6 335.3 337.3 5455.4 6595.4 6624.1 6643.8 6651.5 6592.8 6606.9 6628.1 6637.0 6660.5 4681.3 4803.6 4808.3 4921.8 4963.3 3961.2 4913.8 4957.3 4962.3 4985.8 4878.6 4907.2 4915.1 4926.8 4928.2 4638.9 4705.9 4762.1 4770.7 4851.9 4135.0 4138.3 4139.5 4153.8 4159.8 5622.4 6093.4 6312.2 6358.8 6403.8 5731.7 5741.2 5751.6 5753.7 5785.7 6746.4 6992.4 7006.7 7008.8 7010.6 4691.6 4702.0 4709.0 4718.8 4722.6 6286.2 7234.6 7419.1 7425.9 7445.8 4768.0 4774.2 4774.8 4781.5 4783.2 4833.8 4848.9 4850.3 4851.2 4854.5 5742.6 5750.1 5761.6 5764.1 5775.9 6798.6 7048.3 7052.9 7059.2 7085.8 1395.6 1682.0 1689.2 1693.3 1693.4 1085.6 1095.7 1109.2 1110.8 1118.8 6398.6 6414.6 6580.5 6632.1 6646.1 7478.0 7478.0 7482.0 7482.9 7486.7 6642.7 6666.8 6691.8 6697.6 6699.4 3864.9 3899.3 3901.5 3902.9 3922.3 7447.3 7664.2 7666.9 7670.2 7713.8 6181.7 7503.2 7539.2 7573.3 7577.8 7631.0 7640.7 7660.7 7673.2 7693.2 6042.3 7274.6 7326.9 7339.4 7344.4 6964.5 7260.9 7265.0 7297.7 7319.6 7683.5 7757.8 7778.3 7782.1 7799.7 4186.8 4467.8 4612.3 4668.6 4668.7 7343.1 7367.5 7368.1 7369.1 7382.3 6776.2 7061.3 7110.5 7110.6 7118.9 5766.7 7090.3 7106.2 7110.9 7156.8 6968.9 6973.3 6979.2 6980.3 6988.3 6914.2 7121.4 7123.9 7124.8 7135.9 6668.9 6763.6 6893.6 6969.4 6986.5 18:54:00 INFO - PROCESS | 1952 | 18:54:00 INFO - PROCESS | 1952 | [#5] yui.html Cycles:180 Average:18066.75 Median:3506.28 stddev:25785.54 (735.4%) stddev-sans-first:25825.00 18:54:00 INFO - PROCESS | 1952 | Values: 727.2 754.6 759.8 771.8 775.5 14740.6 14927.6 14935.6 14949.0 14979.6 13843.3 13848.7 13905.9 13925.4 13926.4 720.0 720.5 878.8 880.7 908.8 903.3 904.2 913.7 914.3 916.3 858.9 912.8 961.1 969.5 970.8 762.4 934.7 958.2 960.1 961.6 711.3 712.0 712.1 716.0 716.2 14296.7 14461.2 14531.3 14548.3 14549.6 12386.9 12425.8 12624.6 12681.6 12685.8 9878.2 9947.3 9960.3 10000.4 10288.4 3446.1 3480.6 3491.3 3520.6 3595.8 63600.0 79275.6 79703.0 81379.2 81418.0 9160.4 9239.9 9604.0 9617.8 9693.9 18448.4 22150.3 22161.3 22192.6 22196.7 6373.5 7272.9 7395.0 7403.7 7624.1 3915.5 3972.7 3976.4 3997.0 4000.0 3610.4 3670.6 3679.2 3680.1 3687.7 616.1 631.9 634.4 639.1 641.3 581.2 604.1 606.2 607.2 609.6 8057.6 8066.1 8140.4 8159.6 8445.6 536.2 572.6 593.3 603.0 607.7 3777.7 3802.3 3810.0 3851.8 3952.2 95095.0 95512.0 96936.5 97038.0 97855.0 77922.0 77988.0 77998.6 79269.6 80388.0 69237.6 69479.7 69579.0 69666.7 70976.9 6538.8 7803.5 7838.4 7933.4 7946.4 50437.7 50973.0 51367.0 51425.7 53069.7 49098.8 61966.0 66067.0 70002.0 71776.6 10128.1 10298.4 10375.6 10401.9 10587.3 9714.7 10788.5 10866.7 10884.6 11051.7 9997.5 10241.5 10252.9 10459.8 10582.6 9403.6 10560.6 10825.7 10954.5 11162.3 10865.8 10873.2 11061.4 11212.1 11214.8 9208.9 9234.4 9317.3 9414.7 9758.3 8912.8 9026.0 9027.1 9404.8 9460.5 18:54:00 INFO - PROCESS | 1952 | -------- Summary: end -------- 18:54:00 INFO - PROCESS | 1952 | 18:54:00 INFO - TEST-INFO | 1952: exit 0 18:54:00 INFO - TEST-OK | dromaeo_css | took 1113548ms 18:54:00 INFO - TEST-START | kraken 18:54:00 INFO - operating with platform_type : mac_ 18:54:00 INFO - Initialising browser for kraken test... 18:54:00 INFO - TEST-INFO | started process 1954 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpR7BYfx/profile http://localhost:49665/getInfo.html) 18:54:02 INFO - PROCESS | 1954 | __metrics Screen width/height:1600/1200 18:54:02 INFO - PROCESS | 1954 | colorDepth:24 18:54:02 INFO - PROCESS | 1954 | Browser inner width/height: 1024/689 18:54:02 INFO - PROCESS | 1954 | __metrics 18:54:02 INFO - PROCESS | 1954 | 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" 18:54:02 ERROR - PROCESS | 1954 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 18:54:03 INFO - TEST-INFO | 1954: exit 0 18:54:03 INFO - Browser initialized. 18:54:03 INFO - Running cycle 1/1 for kraken test... 18:54:03 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/T/tmpR7BYfx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 18:54:15 INFO - PROCESS | 1956 | RSS: Main: 243851264 18:54:15 INFO - PROCESS | 1956 | 18:54:18 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49665/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49665/tests/kraken/driver.html?testName=audio-beat-detection) 18:54:18 INFO - PROCESS | 1956 | RSS: Main: 289968128 18:54:18 INFO - PROCESS | 1956 | 18:54:21 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49665/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49665/tests/kraken/driver.html?testName=audio-dft) 18:54:22 INFO - PROCESS | 1956 | RSS: Main: 300441600 18:54:22 INFO - PROCESS | 1956 | 18:54:25 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49665/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49665/tests/kraken/driver.html?testName=audio-fft) 18:54:26 INFO - PROCESS | 1956 | RSS: Main: 287555584 18:54:26 INFO - PROCESS | 1956 | 18:54:27 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49665/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49665/tests/kraken/driver.html?testName=audio-oscillator) 18:54:28 INFO - PROCESS | 1956 | RSS: Main: 290881536 18:54:28 INFO - PROCESS | 1956 | 18:54:30 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49665/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49665/tests/kraken/driver.html?testName=imaging-gaussian-blur) 18:54:31 INFO - PROCESS | 1956 | RSS: Main: 291479552 18:54:31 INFO - PROCESS | 1956 | 18:54:33 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49665/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49665/tests/kraken/driver.html?testName=imaging-darkroom) 18:54:34 INFO - PROCESS | 1956 | RSS: Main: 292184064 18:54:34 INFO - PROCESS | 1956 | 18:54:37 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49665/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49665/tests/kraken/driver.html?testName=imaging-desaturate) 18:54:38 INFO - PROCESS | 1956 | RSS: Main: 292294656 18:54:38 INFO - PROCESS | 1956 | 18:54:41 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49665/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49665/tests/kraken/driver.html?testName=json-parse-financial) 18:54:41 INFO - PROCESS | 1956 | RSS: Main: 292720640 18:54:41 INFO - PROCESS | 1956 | 18:54:43 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49665/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49665/tests/kraken/driver.html?testName=json-stringify-tinderbox) 18:54:43 INFO - PROCESS | 1956 | RSS: Main: 325222400 18:54:43 INFO - PROCESS | 1956 | 18:54:45 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49665/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49665/tests/kraken/driver.html?testName=stanford-crypto-aes) 18:54:46 INFO - PROCESS | 1956 | RSS: Main: 326025216 18:54:46 INFO - PROCESS | 1956 | 18:54:48 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49665/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49665/tests/kraken/driver.html?testName=stanford-crypto-ccm) 18:54:48 INFO - PROCESS | 1956 | RSS: Main: 330821632 18:54:48 INFO - PROCESS | 1956 | 18:54:51 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49665/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49665/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 18:54:52 INFO - PROCESS | 1956 | RSS: Main: 331845632 18:54:52 INFO - PROCESS | 1956 | 18:54:54 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49665/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49665/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 18:54:55 INFO - PROCESS | 1956 | RSS: Main: 331993088 18:54:55 INFO - PROCESS | 1956 | 18:54:57 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:49665/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49665/tests/kraken/driver.html?testName=ai-astar) 18:54:57 INFO - PROCESS | 1956 | RSS: Main: 395124736 18:54:57 INFO - PROCESS | 1956 | 18:54:57 INFO - PROCESS | 1956 | __start_tp_report 18:54:57 INFO - PROCESS | 1956 | _x_x_mozilla_page_load 18:54:57 INFO - PROCESS | 1956 | _x_x_mozilla_page_load_details 18:54:57 INFO - PROCESS | 1956 | |i|pagename|runs| 18:54:57 INFO - PROCESS | 1956 | |0;ai-astar;112;107;113;112;111;112;117;112;112;113 18:54:57 INFO - PROCESS | 1956 | |1;audio-beat-detection;153;121;142;155;118;140;143;140;171;119 18:54:57 INFO - PROCESS | 1956 | |2;audio-dft;186;186;188;199;254;186;185;183;185;181 18:54:57 INFO - PROCESS | 1956 | |3;audio-fft;74;75;82;80;57;58;57;79;80;56 18:54:57 INFO - PROCESS | 1956 | |4;audio-oscillator;92;95;128;78;78;81;119;79;79;122 18:54:57 INFO - PROCESS | 1956 | |5;imaging-gaussian-blur;89;86;90;86;89;86;90;87;88;91 18:54:57 INFO - PROCESS | 1956 | |6;imaging-darkroom;95;95;96;96;100;96;91;132;146;95 18:54:57 INFO - PROCESS | 1956 | |7;imaging-desaturate;87;85;87;87;84;91;108;109;132;132 18:54:57 INFO - PROCESS | 1956 | |8;json-parse-financial;54;55;56;54;53;54;55;67;55;53 18:54:57 INFO - PROCESS | 1956 | |9;json-stringify-tinderbox;64;64;75;78;72;71;69;69;70;69 18:54:57 INFO - PROCESS | 1956 | |10;stanford-crypto-aes;85;83;83;83;84;84;82;85;86;84 18:54:57 INFO - PROCESS | 1956 | |11;stanford-crypto-ccm;134;131;111;135;132;127;131;119;122;127 18:54:57 INFO - PROCESS | 1956 | |12;stanford-crypto-pbkdf2;170;174;178;146;143;130;142;125;141;145 18:54:57 INFO - PROCESS | 1956 | |13;stanford-crypto-sha256-iterative;68;66;66;69;66;74;90;77;66;67 18:54:57 INFO - PROCESS | 1956 | __end_tp_report 18:54:57 INFO - PROCESS | 1956 | __start_cc_report 18:54:57 INFO - PROCESS | 1956 | _x_x_mozilla_cycle_collect,1248 18:54:57 INFO - PROCESS | 1956 | __end_cc_report 18:54:57 INFO - PROCESS | 1956 | __startTimestamp1458957297356__endTimestamp 18:54:57 INFO - PROCESS | 1956 | 18:54:57 INFO - PROCESS | 1956 | ------- Summary: start ------- 18:54:57 INFO - PROCESS | 1956 | Number of tests: 14 18:54:57 INFO - PROCESS | 1956 | 18:54:57 INFO - PROCESS | 1956 | [#0] ai-astar Cycles:10 Average:112.10 Median:112.00 stddev:2.42 (2.2%) stddev-sans-first:2.57 18:54:57 INFO - PROCESS | 1956 | Values: 112.0 107.0 113.0 112.0 111.0 112.0 117.0 112.0 112.0 113.0 18:54:57 INFO - PROCESS | 1956 | 18:54:57 INFO - PROCESS | 1956 | [#1] audio-beat-detection Cycles:10 Average:140.20 Median:142.50 stddev:17.17 (12.0%) stddev-sans-first:17.58 18:54:57 INFO - PROCESS | 1956 | Values: 153.0 121.0 142.0 155.0 118.0 140.0 143.0 140.0 171.0 119.0 18:54:57 INFO - PROCESS | 1956 | 18:54:57 INFO - PROCESS | 1956 | [#2] audio-dft Cycles:10 Average:193.30 Median:186.00 stddev:21.86 (11.8%) stddev-sans-first:23.02 18:54:57 INFO - PROCESS | 1956 | Values: 186.0 186.0 188.0 199.0 254.0 186.0 185.0 183.0 185.0 181.0 18:54:57 INFO - PROCESS | 1956 | 18:54:57 INFO - PROCESS | 1956 | [#3] audio-fft Cycles:10 Average:69.80 Median:77.00 stddev:11.27 (14.6%) stddev-sans-first:11.85 18:54:57 INFO - PROCESS | 1956 | Values: 74.0 75.0 82.0 80.0 57.0 58.0 57.0 79.0 80.0 56.0 18:54:57 INFO - PROCESS | 1956 | 18:54:57 INFO - PROCESS | 1956 | [#4] audio-oscillator Cycles:10 Average:95.10 Median:79.00 stddev:20.25 (25.6%) stddev-sans-first:21.44 18:54:57 INFO - PROCESS | 1956 | Values: 92.0 95.0 128.0 78.0 78.0 81.0 119.0 79.0 79.0 122.0 18:54:57 INFO - PROCESS | 1956 | 18:54:57 INFO - PROCESS | 1956 | [#5] imaging-gaussian-blur Cycles:10 Average:88.20 Median:89.00 stddev:1.87 (2.1%) stddev-sans-first:1.96 18:54:57 INFO - PROCESS | 1956 | Values: 89.0 86.0 90.0 86.0 89.0 86.0 90.0 87.0 88.0 91.0 18:54:57 INFO - PROCESS | 1956 | 18:54:57 INFO - PROCESS | 1956 | [#6] imaging-darkroom Cycles:10 Average:104.20 Median:95.00 stddev:18.76 (19.7%) stddev-sans-first:19.60 18:54:57 INFO - PROCESS | 1956 | Values: 95.0 95.0 96.0 96.0 100.0 96.0 91.0 132.0 146.0 95.0 18:54:57 INFO - PROCESS | 1956 | 18:54:57 INFO - PROCESS | 1956 | [#7] imaging-desaturate Cycles:10 Average:100.20 Median:86.00 stddev:19.04 (22.1%) stddev-sans-first:19.58 18:54:57 INFO - PROCESS | 1956 | Values: 87.0 85.0 87.0 87.0 84.0 91.0 108.0 109.0 132.0 132.0 18:54:57 INFO - PROCESS | 1956 | 18:54:57 INFO - PROCESS | 1956 | [#8] json-parse-financial Cycles:10 Average:55.60 Median:55.00 stddev:4.12 (7.5%) stddev-sans-first:4.32 18:54:57 INFO - PROCESS | 1956 | Values: 54.0 55.0 56.0 54.0 53.0 54.0 55.0 67.0 55.0 53.0 18:54:57 INFO - PROCESS | 1956 | 18:54:57 INFO - PROCESS | 1956 | [#9] json-stringify-tinderbox Cycles:10 Average:70.10 Median:70.50 stddev:4.33 (6.1%) stddev-sans-first:3.99 18:54:57 INFO - PROCESS | 1956 | Values: 64.0 64.0 75.0 78.0 72.0 71.0 69.0 69.0 70.0 69.0 18:54:57 INFO - PROCESS | 1956 | 18:54:57 INFO - PROCESS | 1956 | [#10] stanford-crypto-aes Cycles:10 Average:83.90 Median:84.00 stddev:1.20 (1.4%) stddev-sans-first:1.20 18:54:57 INFO - PROCESS | 1956 | Values: 85.0 83.0 83.0 83.0 84.0 84.0 82.0 85.0 86.0 84.0 18:54:57 INFO - PROCESS | 1956 | 18:54:57 INFO - PROCESS | 1956 | [#11] stanford-crypto-ccm Cycles:10 Average:126.90 Median:131.00 stddev:7.56 (5.8%) stddev-sans-first:7.57 18:54:57 INFO - PROCESS | 1956 | Values: 134.0 131.0 111.0 135.0 132.0 127.0 131.0 119.0 122.0 127.0 18:54:57 INFO - PROCESS | 1956 | 18:54:57 INFO - PROCESS | 1956 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:149.40 Median:145.50 stddev:18.31 (12.6%) stddev-sans-first:17.84 18:54:57 INFO - PROCESS | 1956 | Values: 170.0 174.0 178.0 146.0 143.0 130.0 142.0 125.0 141.0 145.0 18:54:57 INFO - PROCESS | 1956 | 18:54:57 INFO - PROCESS | 1956 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.90 Median:68.50 stddev:7.71 (11.3%) stddev-sans-first:8.11 18:54:57 INFO - PROCESS | 1956 | Values: 68.0 66.0 66.0 69.0 66.0 74.0 90.0 77.0 66.0 67.0 18:54:57 INFO - PROCESS | 1956 | -------- Summary: end -------- 18:54:57 INFO - PROCESS | 1956 | 18:54:58 INFO - TEST-INFO | 1956: exit 0 18:54:58 INFO - TEST-OK | kraken | took 57591ms 18:54:58 INFO - SUITE-END | took 1171s 18:54:58 INFO - Completed test suite (00:19:31) 18:54:58 INFO - javascript benchmark 18:54:58 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3420.794752314861, 3478.9826050869756, 3499.300139972006, 3524.9471257931127, 3567.5005499230097, 4731.29030645403, 5629.0, 5632.3804381518, 5676.318841738997, 5703.714814259291, 4780.0, 5628.493435590796, 5717.571182161334, 5719.4566516181, 5720.084786434171, 5159.458256883029, 5160.277561141434, 5194.194899790538, 5209.973950130263, 5276.894462110775, 5273.156294992802, 5277.6305658603915, 5285.947140528603, 5289.629725919187, 5290.153575427932, 5186.0665080285535, 5233.058049551079, 5236.528712415882, 5262.342207224097, 5278.076336641073, 5268.973655131719, 5303.575713942875, 5323.4357376739645, 5323.840284791462, 5331.5201631853315, 5111.207762796773, 5129.179331306973, 5139.408967968694, 5228.215767634847, 5244.947550524484, 5638.661680299195, 5659.971700141514, 5667.518260947824, 5680.6591604503865, 5753.050746626802, 6278.843028924268, 6284.497240220771, 6287.591306565105, 6288.87422251557, 6289.308176100625, 6117.5717699761035, 6131.662758548278, 6234.781782637586, 6346.921023425983, 6352.237731472207, 5818.534517238653, 5825.0, 5830.591858569859, 5832.416758324133, 5852.385499522574, 6339.809805705836, 6366.331535188831, 6367.331430199855, 6372.808815735535, 6374.872502550016, 5817.0983497557945, 6059.33347331802, 6118.611691595641, 6146.969265153735, 6147.139400483936, 6200.286966998763, 6222.81331560054, 6273.0, 6276.027215781562, 6293.2762732285455, 6145.477634401037, 6182.783602573888, 6203.875922481525, 6204.100405441186, 6206.038064100072, 5193.740312984336, 6094.329623741385, 6115.970584430425, 6164.537659675542, 6276.278228003746, 4880.585150262196, 4884.633652476078, 4887.731174785421, 4898.951010489849, 4920.778564964585, 4377.890552736207, 4384.232759267115, 4386.8025938832825, 4389.934150987738, 4431.711938723973, 5624.97187514068, 5710.885782284331, 5714.485696287354, 5719.056355701263, 5724.084146536534, 6135.159297383386, 6198.349173336735, 6237.563370564017, 6237.812865614039, 6261.342559031327, 5623.5220006299105, 5692.345380281321, 5706.115552089433, 5708.771649133988, 5808.79669211584, 5345.465453454701, 5383.380911195262, 5395.541378982752, 5420.0, 5427.891442171213, 6349.238091429058, 6349.777757778455, 6353.968230158912, 6357.7139028742895, 6366.554341196164, 6187.381261873777, 6190.907136392868, 6324.367563243639, 6324.715387807468, 6325.652089135142, 6284.591501552384, 6349.904751428639, 6358.982562789932, 6361.459275961595, 6362.04569314588, 6115.510759139347, 6135.11040899076, 6141.07883817431, 6142.815715528542, 6180.258368995749, 6109.131392048963, 6235.625862448268, 6274.278457977391, 6284.308726040041, 6299.905501417574, 6035.668038257938, 6048.546359023003, 6051.576389652682, 6053.878922421615, 6082.878342433038, 5967.641941483351, 6063.605865618721, 6068.575199736153, 6083.969580152071, 6087.908681369694, 5874.676892770768, 5908.852278693067, 5914.053751399755, 5914.7338369774325, 5921.733521991435, 5927.199828023162, 5971.044632858721, 5981.671008094422, 5990.9700451497465, 6009.399060093956, 5965.194698715618, 5969.641821490724, 5970.462658360769, 5984.222051133324, 5986.102084687332], "unit": "score", "name": "dojo.html", "value": 5693.838821969412}, {"lowerIsBetter": false, "replicates": [447.2173696031944, 510.4844107451473, 544.686805087075, 628.864794069275, 639.9552031357804, 26711.0, 29964.850175749118, 29978.85010574947, 30115.0, 38125.0, 29617.85191074047, 41424.79287603558, 41471.75584732455, 41491.0, 41627.0, 9345.06549345067, 9591.232701383873, 9618.663346782863, 9623.663171788989, 9633.229341652686, 9408.012158723339, 9539.427634341928, 9548.570314335837, 9552.474613896233, 9578.760530986747, 9464.763380915498, 9679.758006049835, 9694.66068687596, 9701.175400091, 9725.465099419565, 9590.328676992613, 9659.951700241454, 9669.758256043584, 9675.903240967571, 9680.419174849532, 9500.477473738942, 9610.183134433582, 9635.614575416976, 9658.903410965871, 9668.371555848847, 39723.20553588912, 39956.40065399021, 39966.40050399247, 39975.40036899449, 39995.600043999475, 3171.9207019824457, 3231.4991176367703, 3268.4607039838397, 3353.111425472252, 3672.4307732301536, 27443.451130977268, 27593.034243801572, 27626.447471050466, 28051.737671804818, 28233.858830705714, 2729.0, 2761.1716485054403, 2784.763295119917, 2860.6281183446226, 2905.0102264679963, 491833.0, 494540.0, 496165.0, 496196.0, 496464.5176774129, 67780.66109669518, 68169.0, 68623.65688171527, 68758.0, 68786.0, 72351.6382418095, 72986.63506682539, 73982.6300868503, 74171.0, 74338.14154646177, 16352.100634465218, 16531.752023719655, 16543.420980265873, 16561.08914009741, 16593.751093733605, 11495.310281383145, 11884.286942783461, 12496.375181240901, 12571.748565028649, 12590.748185036247, 20977.16091356359, 21230.36308910735, 21314.78685213128, 21316.04077816502, 21332.680009799864, 7658.234176582298, 7714.382849372037, 8814.86777698335, 9026.743314171457, 9030.503322317336, 882.342654722236, 947.7441090905555, 1028.8250997330472, 1053.7049626104704, 1129.4352823588206, 28552.428951421272, 28818.828593635157, 29100.0, 29108.0, 29401.0, 1030.5208078243652, 1095.6767753512574, 1110.7889500994786, 1183.526589364261, 1220.1093201962617, 14634.634134146732, 14720.631984200481, 14815.777763333559, 14984.850151498564, 15067.698646027018, 528538.0, 530168.0, 536066.0, 536909.0, 539375.0, 58649.0, 59323.40676593179, 59408.0, 59408.40591594029, 59517.40482595205, 1154.4285578638628, 1435.2967046147312, 1453.9127652340894, 1461.3058797071305, 1488.2038109611522, 27730.0, 28275.717242827308, 28358.29104272327, 28783.8560807203, 29245.85377073101, 46368.0, 47011.52988470208, 47284.29073563968, 47290.29064563965, 47327.81680458016, 371397.1430142832, 374039.0, 374243.0, 374737.1263143667, 374967.0, 28042.579361310003, 32198.35603287968, 32850.671493285714, 33278.0, 33388.66611333856, 40638.79680601578, 41279.7936010318, 41477.792611036755, 41818.37272440977, 42268.577314226466, 27521.724782751917, 34448.138796530286, 34721.9583412498, 35162.64837351696, 35442.291154177285, 33910.66089339075, 34176.48735269023, 34385.48421773625, 34605.9236445814, 34847.825760871034, 34846.303073938885, 35166.82416587901, 35703.0, 35996.0, 36755.0, 30522.389552209275, 31073.223169420944, 31082.844585776926, 31140.065798026095, 31147.84426077855, 23393.527730816033, 23631.409214769767, 23840.284791456284, 23937.880310598335, 23983.880080599487], "unit": "score", "name": "ext.html", "value": 19389.215266420913}, {"lowerIsBetter": false, "replicates": [306.3597082098414, 354.6028448138084, 360.33166439385633, 361.9113317237276, 367.60666087286614, 15146.0, 18897.0, 19326.487556617638, 20104.798952010475, 20127.59744805103, 18775.0, 19703.31038413656, 19928.103235354407, 19960.700589491134, 19966.900165499188, 5599.160125981095, 5886.705664716747, 5933.317668468138, 5982.670953097578, 5984.162217289561, 4208.915821683579, 4405.713628614129, 4446.333050042487, 4452.421185245914, 5824.126381042856, 6265.091561723548, 6539.836504087412, 6540.607563546178, 6541.967290163567, 6554.41010309072, 6231.345708700589, 6365.681715914186, 6386.999999999976, 6396.104545363606, 6411.6153030818305, 3629.4555816627453, 5354.464553544653, 5496.0931446311315, 5527.336719593634, 5536.335639723259, 24218.515629687485, 24291.0, 24609.892554834896, 24802.131925382706, 24842.751572484405, 2147.527543940331, 2157.7410710714817, 2254.0, 2283.7259528856644, 2300.5053913408697, 14257.572272831832, 14439.566812995521, 14733.968622196451, 14916.105033698013, 14926.552203433914, 1695.211726547149, 1716.2877405876545, 1744.110503643151, 1773.5388798912247, 1794.7397627343962, 84592.57703711504, 89296.42814287421, 101940.0, 103443.93112137716, 103549.48225258825, 9767.706968790948, 10316.793664126826, 10672.946635266773, 10924.344539327665, 11174.497147628375, 13351.73296534064, 13421.664458388423, 13480.393382297623, 13487.865121348857, 13489.12320699171, 6991.300869912968, 7461.694203514472, 8121.106678265386, 8311.090384100076, 8439.620217090123, 8090.190980901981, 8517.44636598619, 8527.872081918777, 8612.8708069379, 8629.0, 4343.67422443318, 4410.977945110254, 4418.7127836690515, 4441.800713807254, 4463.66522510813, 1728.8444040036456, 1781.358710864088, 1790.2838864454322, 1794.255384015645, 1816.7910690270523, 789.9960500197577, 910.5113140015989, 915.4827522449928, 986.8667729856378, 999.4652860719481, 19049.0, 19815.12680661296, 19859.900700496404, 19982.0, 20147.597048058957, 945.2060269373759, 945.7210123013728, 967.3857100740939, 1005.9789313846452, 1044.5821671331375, 8678.86981695275, 10748.0, 10972.945135274273, 10985.39580323074, 11006.009459148716, 510871.0, 519402.0, 520786.0, 630390.8480457568, 632383.0, 106758.96903511761, 112274.87725122807, 115441.0, 116851.0, 117694.41152794352, 961.5721004153085, 1012.4077414712476, 1024.626011505795, 1058.6136060337922, 1067.3969207397795, 15864.44474443389, 18333.083345832387, 18405.723914141032, 18424.078796059875, 18608.06959651985, 48656.2701559484, 49043.01913961772, 49393.0, 50689.74655126701, 50801.49198507968, 70677.0, 71892.0, 72129.6393518029, 72259.63870180615, 72370.0, 7593.278638529331, 7597.772066838003, 7772.261635144652, 7798.298153166243, 7882.132965373919, 9127.908720912706, 11607.187496875138, 11981.76036479283, 12274.140810143204, 12288.938555307524, 10361.378317300685, 10583.364998100138, 10730.356178629307, 10780.622678206226, 10966.287191332538, 10199.592016319264, 10398.324108932895, 10562.788744225227, 10632.574697012033, 10825.0, 10765.30025548337, 10909.236353455182, 11028.889711102785, 11212.775744485229, 11237.438128093727, 6435.967820160869, 7728.033995750531, 7759.146493885555, 7829.060512738508, 7880.05439347282, 9632.95183524078, 10729.141668666643, 10942.398168100832, 10997.450127493754, 11019.393933333424], "unit": "score", "name": "jquery.html", "value": 9213.687642021916}, {"lowerIsBetter": false, "replicates": [1463.8536146385356, 1600.0239853689247, 1636.1982628512028, 1901.2585091814194, 2018.4852862520065, 7975.202479752029, 8201.548914809682, 8203.54880481574, 8206.876896846545, 8212.630431630576, 8086.312663423601, 8455.281301089415, 8624.741257762276, 8656.610452529636, 8664.783380415493, 2417.6494408310787, 2497.8126640501946, 2498.912538061168, 2500.0124950644486, 2500.949981000388, 2103.3900168951063, 2167.945801354963, 2407.9759202408013, 2424.7938925191293, 2492.663490428787, 2421.455172586163, 2456.349067497115, 2459.0, 2462.729099799021, 2466.050570530341, 2408.0488207158164, 2464.4085419499193, 2465.9642949961058, 2466.235467005225, 2469.77772000519, 2332.2187067332466, 2344.355302291883, 2381.9047238110456, 2385.093664407514, 2386.4391867911027, 8589.527575983318, 8657.393982421234, 8679.826403471896, 8688.0, 8865.955670221672, 5372.7045012524295, 5532.419095994943, 5534.723263836792, 5569.359523654751, 5578.832635020955, 3462.5498685170764, 3462.9653703463146, 3557.1107223194203, 3618.7285953553323, 3618.981905090484, 1068.7167900506372, 1085.3596378136858, 1613.6127329440967, 1649.983500164995, 1668.3410053029106, 12020.69948251292, 12072.094592905567, 12073.335966521838, 12077.758444831143, 12184.51261949521, 4145.129522800185, 4604.171249175113, 4605.861824145281, 4745.501722319107, 4791.904161916742, 9436.339456237998, 9457.716268511957, 9459.101385368516, 9460.148586627236, 9461.479618621042, 5484.698341591171, 5491.450854914477, 5493.615446918758, 5501.862453438696, 5502.972485137549, 5014.373203349582, 5109.693418394908, 5113.386393632788, 5116.641835071509, 5118.59051275897, 3658.9817050914576, 3664.706823454117, 3667.6882464990776, 3713.517242758478, 3713.721470889694, 1122.2537012886503, 1153.948072336747, 1194.635636130971, 1204.3857632607433, 1211.8788121187988, 1266.4807428954268, 1332.253937794838, 1358.2393859438746, 1388.4862600837553, 1424.017427974694, 8215.260626543639, 8377.120402357665, 8388.245057944814, 8395.32837373021, 8409.41134120618, 1060.4273692206277, 1110.744528758374, 1195.2768575011992, 1215.2040413529153, 1218.4577862851124, 6336.841578960563, 6343.5876668016435, 6450.967745161244, 6451.064595633607, 6458.644774537352, 9216.447013179231, 10507.894921050845, 10992.560297588167, 11068.833967490495, 11125.943035411623, 10811.78376432467, 10858.185636077325, 10887.129029677606, 10968.725781855357, 10998.0, 8442.451240669337, 8563.88669472977, 8582.828343433097, 8620.758602763326, 8644.654213831376, 7758.495697779626, 7983.281504664608, 8035.879461807961, 8069.919300807152, 8126.106128325761, 9513.952430237805, 9756.707298781048, 9897.158741507052, 9906.900930990598, 10050.447225402673, 9902.950485247527, 10126.645567405105, 10163.034511721375, 10282.280240383101, 10293.43386113771, 6671.532992690465, 7027.6837542309695, 7116.46626503004, 7214.134303883568, 7219.747308844166, 7426.628668566658, 8349.499030058216, 8402.11777763326, 8447.408681392244, 8457.02744184402, 6591.835204119743, 7502.699892004477, 7508.924910750822, 7535.8116047099265, 7701.075870895304, 7308.30571095745, 7470.140933792466, 7497.325240728361, 7523.7366692165515, 7528.698852045857, 7762.61186940662, 7881.684732610632, 7892.1318654949055, 7899.921000789918, 7902.723404680809, 7037.0, 7148.892766608609, 7155.177154627285, 7161.606111663908, 7252.129744430491, 7291.489595728248, 7360.411167106511, 7364.594947277951, 7372.668229929774, 7379.667914943733], "unit": "score", "name": "mootools.html", "value": 4986.111598794615}, {"lowerIsBetter": false, "replicates": [323.71836502243053, 328.5712145649927, 333.5613668026546, 335.2774770369853, 337.2513021093174, 5455.399906010346, 6595.373439523243, 6624.072629831821, 6643.833904152399, 6651.501137414702, 6592.80221593353, 6606.867862642756, 6628.072069910217, 6637.004449332602, 6660.500462465322, 4681.297805329194, 4803.61571074315, 4808.278758186265, 4921.818763496753, 4963.280324352967, 3961.227560625679, 4913.845246367101, 4957.256411538262, 4962.305277261186, 4985.775640096204, 4878.585320247783, 4907.2148456247005, 4915.090708218973, 4926.753662316888, 4928.23612340086, 4638.884027899296, 4705.929411058837, 4762.071396077767, 4770.666053376265, 4851.878703032417, 4135.048938744106, 4138.296489596745, 4139.544650088488, 4153.792310384499, 4159.83360665573, 5622.409646987048, 6093.360197179321, 6312.179416675803, 6358.77744278948, 6403.8399040023905, 5731.713414329267, 5741.19623252745, 5751.626144300607, 5753.741081651336, 5785.681787501686, 6746.359095885932, 6992.370686638176, 7006.684699188549, 7008.808502554578, 7010.649467526654, 4691.577758001797, 4702.0, 4708.976455117737, 4718.811247550094, 4722.574968252839, 6286.182796236506, 7234.60209688467, 7419.10970683516, 7425.925740742631, 7445.813854653623, 4767.976160119247, 4774.188387974053, 4774.785134668949, 4781.474037855833, 4783.210770222944, 4833.830815921426, 4848.854534363974, 4850.345203397566, 4851.151048566487, 4854.514548545118, 5742.598018138774, 5750.079987202112, 5761.567882408836, 5764.13537969308, 5775.8556036099435, 6798.558093723892, 7048.330408611174, 7052.858942821114, 7059.2234854166, 7085.775971932758, 1395.6441107517721, 1681.957951051209, 1689.2398420710483, 1693.3480609965252, 1693.4242357598475, 1085.625459216569, 1095.7260684828793, 1109.2180013090751, 1110.816715241976, 1118.7818375416716, 6398.5521013528605, 6414.61512309263, 6580.539362244693, 6632.071509988606, 6646.102776125258, 7478.0, 7478.0, 7482.0, 7482.925170748332, 7486.700531978769, 6642.701078451385, 6666.766663166766, 6691.799246022627, 6697.564658297195, 6699.430548403343, 3864.903377415531, 3899.29812633723, 3901.492805935267, 3902.941455878164, 3922.254771593445, 7447.316710415512, 7664.233576642403, 7666.8849967250535, 7670.194629563927, 7713.7685869424, 6181.660008699565, 7503.212162722944, 7539.246075392417, 7573.318401343795, 7577.810554736066, 7631.0, 7640.656170472454, 7660.655270512729, 7673.232676732394, 7693.153753087156, 6042.335343112166, 7274.599897005715, 7326.890096648661, 7339.449541284318, 7344.375728063174, 6964.477664175106, 7260.891086633599, 7265.019222405119, 7297.708091676273, 7319.560826350223, 7683.538987660758, 7757.7672669819995, 7778.338841198335, 7782.066152061789, 7799.727009554638, 4186.83252669902, 4467.776611169364, 4612.285095810154, 4668.626509879134, 4668.719876807402, 7343.118825740731, 7367.484276100621, 7368.078990126234, 7369.115706115301, 7382.335589796944, 6776.186857577122, 7061.329173728487, 7110.5022648414115, 7110.6089165094345, 7118.85762284741, 5766.711664416678, 7090.290970902868, 7106.182788979334, 7110.857782844418, 7156.821079473055, 6968.895466567904, 6973.302669732986, 6979.1973922999505, 6980.267071957372, 6988.301169882971, 6914.239433662394, 7121.430285577245, 7123.857522849617, 7124.821879453055, 7135.89393643986, 6668.933310666831, 6763.5941843489545, 6893.551919125241, 6969.372756451944, 6986.476014298846], "unit": "score", "name": "prototype.html", "value": 5177.297266787995}, {"lowerIsBetter": false, "replicates": [727.2436665867498, 754.6453167011503, 759.8252401947552, 771.8340556780298, 775.5269285735702, 14740.557783266506, 14927.552173434815, 14935.551933442, 14949.028313159637, 14979.625509362271, 13843.30783460828, 13848.723025539482, 13905.860941390583, 13925.37335819888, 13926.373313200906, 720.0135813934917, 720.5100531638484, 878.846201914664, 880.744584070622, 908.7728067983004, 903.2999425445266, 904.1636486250225, 913.7258822353301, 914.3188324698109, 916.2669864108686, 858.8582883824162, 912.7854954085784, 961.0581630002602, 969.5152423788106, 970.7573106723319, 762.3558093411059, 934.654177954158, 958.2238386906628, 960.1071003966308, 961.5576834656067, 711.2531841566387, 712.0245263988318, 712.1383126417041, 716.0, 716.1978583985968, 14296.714065718628, 14461.20463374514, 14531.346089426, 14548.345324460424, 14549.636259093608, 12386.938065309705, 12425.75148497034, 12624.55814046504, 12681.619551413472, 12685.809712854314, 9878.209743220597, 9947.303688741791, 9960.252981026451, 10000.449975251358, 10288.382697038202, 3446.1212390840174, 3480.617132115465, 3491.284286721216, 3520.5951315598522, 3595.8381872815526, 63600.0, 79275.60362198151, 79703.0, 81379.18620813775, 81418.0, 9160.358774885828, 9239.907600923905, 9604.0, 9617.807643847224, 9693.903060969442, 18448.446546603624, 22150.33548993533, 22161.33515994523, 22192.55614887693, 22196.667049994263, 6373.458256048195, 7272.854542909112, 7395.038644976226, 7403.703851845974, 7624.085109786861, 3915.5497117831815, 3972.7219094663674, 3976.4234186042863, 3997.0, 3999.9800000999808, 3610.4223324268514, 3670.5778835433734, 3679.2273622539565, 3680.061584296041, 3687.668109870071, 616.1004932798165, 631.8894193516209, 634.403660559073, 639.0988705924624, 641.2785616181795, 581.183437270627, 604.0637012630406, 606.2391698418456, 607.1863702638485, 609.5763444406184, 8057.556834374049, 8066.072401673765, 8140.389470789596, 8159.551224682581, 8445.57772111392, 536.1903525676179, 572.6220694341714, 593.2613895699795, 602.9849253768691, 607.6809674920702, 3777.6788972937607, 3802.334591446486, 3810.028442747082, 3851.768893866377, 3952.2490726761825, 95095.0, 95512.04487955032, 96936.51531742296, 97038.0, 97855.0, 77922.0, 77988.0, 77998.6100069496, 79269.60365198136, 80388.0, 69237.61524769476, 69479.65260173767, 69579.0, 69666.65166674236, 70976.93534596985, 6538.8365290868105, 7803.453758236869, 7838.412119090977, 7933.3653307736395, 7946.40401969843, 50437.747811262176, 50973.0, 51367.0, 51425.7428712854, 53069.73465132649, 49098.75450622724, 61966.0, 66067.0, 70002.0, 71776.64111679408, 10128.139108175888, 10298.409112303516, 10375.584976600852, 10401.895981040396, 10587.258891877495, 9714.708558743248, 10788.460576971276, 10866.728331791768, 10884.619038333936, 11051.72370690739, 9997.450140242065, 10241.539130738985, 10252.948735256276, 10459.843102353623, 10582.576696932036, 9403.576839042124, 10560.630377936735, 10825.67522974312, 10954.452277386259, 11162.274452160584, 10865.782953542783, 10873.161353779971, 11061.400570866, 11212.14525117515, 11214.83177752318, 9208.861867072133, 9234.445933244027, 9317.301202409983, 9414.717558473258, 9758.283784995285, 8912.777180570538, 9026.0, 9027.121174421498, 9404.764880878032, 9460.526973651153], "unit": "score", "name": "yui.html", "value": 6770.779469302794}], "name": "dromaeo_css", "value": 7498.758164813358}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 107.0, 113.0, 112.0, 111.0, 112.0, 117.0, 112.0, 112.0, 113.0], "unit": "score", "name": "ai-astar", "value": 112.1}, {"lowerIsBetter": true, "replicates": [153.0, 121.0, 142.0, 155.0, 118.0, 140.0, 143.0, 140.0, 171.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 140.2}, {"lowerIsBetter": true, "replicates": [186.0, 186.0, 188.0, 199.0, 254.0, 186.0, 185.0, 183.0, 185.0, 181.0], "unit": "score", "name": "audio-dft", "value": 193.3}, {"lowerIsBetter": true, "replicates": [74.0, 75.0, 82.0, 80.0, 57.0, 58.0, 57.0, 79.0, 80.0, 56.0], "unit": "score", "name": "audio-fft", "value": 69.8}, {"lowerIsBetter": true, "replicates": [92.0, 95.0, 128.0, 78.0, 78.0, 81.0, 119.0, 79.0, 79.0, 122.0], "unit": "score", "name": "audio-oscillator", "value": 95.1}, {"lowerIsBetter": true, "replicates": [89.0, 86.0, 90.0, 86.0, 89.0, 86.0, 90.0, 87.0, 88.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 88.2}, {"lowerIsBetter": true, "replicates": [95.0, 95.0, 96.0, 96.0, 100.0, 96.0, 91.0, 132.0, 146.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 104.2}, {"lowerIsBetter": true, "replicates": [87.0, 85.0, 87.0, 87.0, 84.0, 91.0, 108.0, 109.0, 132.0, 132.0], "unit": "score", "name": "imaging-desaturate", "value": 100.2}, {"lowerIsBetter": true, "replicates": [54.0, 55.0, 56.0, 54.0, 53.0, 54.0, 55.0, 67.0, 55.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.6}, {"lowerIsBetter": true, "replicates": [64.0, 64.0, 75.0, 78.0, 72.0, 71.0, 69.0, 69.0, 70.0, 69.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 70.1}, {"lowerIsBetter": true, "replicates": [85.0, 83.0, 83.0, 83.0, 84.0, 84.0, 82.0, 85.0, 86.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 83.9}, {"lowerIsBetter": true, "replicates": [134.0, 131.0, 111.0, 135.0, 132.0, 127.0, 131.0, 119.0, 122.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.9}, {"lowerIsBetter": true, "replicates": [170.0, 174.0, 178.0, 146.0, 143.0, 130.0, 142.0, 125.0, 141.0, 145.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 149.4}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 66.0, 69.0, 66.0, 74.0, 90.0, 77.0, 66.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.9}], "name": "kraken", "value": 1459.9000000000005}]} 18:54:58 INFO - Return code: 0 18:54:58 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 18:54:58 ERROR - # TBPL SUCCESS # 18:54:58 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:54:58 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:54:58 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:54:58 INFO - 2016-03-25 18:54:58.649 screenresolution[1960:15829] starting screenresolution argv=screenresolution get 18:54:58 INFO - 2016-03-25 18:54:58.651 screenresolution[1960:15829] Display 0: 1600x1200x32@60 18:54:58 INFO - 2016-03-25 18:54:58.657 screenresolution[1961:15832] starting screenresolution argv=screenresolution list 18:54:58 INFO - Available Modes on Display 0 18:54:58 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:54:58 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:54:58 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:54:58 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:54:58 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:54:58 INFO - Intel Iris: 18:54:58 INFO - Chipset Model: Intel Iris 18:54:58 INFO - Type: GPU 18:54:58 INFO - Bus: Built-In 18:54:58 INFO - VRAM (Dynamic, Max): 1536 MB 18:54:58 INFO - Vendor: Intel (0x8086) 18:54:58 INFO - Device ID: 0x0a2e 18:54:58 INFO - Revision ID: 0x0009 18:54:58 INFO - Displays: 18:54:58 INFO - Display: 18:54:58 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:54:58 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:54:58 INFO - Display Serial Number: 1600x1200 60 18:54:58 INFO - Main Display: Yes 18:54:58 INFO - Mirror: Off 18:54:58 INFO - Online: Yes 18:54:58 INFO - Rotation: Supported 18:54:58 INFO - Return code: 0 18:54:58 INFO - Running post-action listener: _resource_record_post_action 18:54:58 INFO - Running post-run listener: _resource_record_post_run 18:54:59 INFO - Total resource usage - Wall time: 1207s; CPU: 53.0%; Read bytes: 2433024; Write bytes: 705156096; Read time: 48; Write time: 2311 18:54:59 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 393943552; Write bytes: 388920832; Read time: 29764; Write time: 735 18:54:59 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 2433024; Write bytes: 298855936; Read time: 48; Write time: 1536 18:54:59 INFO - Running post-run listener: _upload_blobber_files 18:54:59 INFO - Blob upload gear active. 18:54:59 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 18:54:59 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 18:54:59 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', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 18:54:59 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 Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 18:55:00 INFO - (blobuploader) - INFO - Open directory for files ... 18:55:00 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 18:55:00 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:55:00 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:55:01 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 18:55:01 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:55:01 INFO - (blobuploader) - INFO - Done attempting. 18:55:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 18:55:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 18:55:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 18:55:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 18:55:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 18:55:02 INFO - (blobuploader) - INFO - Done attempting. 18:55:02 INFO - (blobuploader) - INFO - Iteration through files over. 18:55:02 INFO - Return code: 0 18:55:02 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 18:55:02 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 18:55:02 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c54b960cd08508877353590b3425757697af99371b9d2cd5c0cfafefc435bcf32105b3a7b910883ec94dc4969e37054bdac8a085a5385285b6572ed9bbd51cb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7dbaf47e067289747ef65540a09c256f7427bf25eb4d315c43de820d75b4105ed0456c26e89bacc1b353c1ae715c13a0b773ca0673cd6a73cf44bfcc1835053"} 18:55:02 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 18:55:02 INFO - Writing to file /builds/slave/test/properties/blobber_files 18:55:02 INFO - Contents: 18:55:02 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c54b960cd08508877353590b3425757697af99371b9d2cd5c0cfafefc435bcf32105b3a7b910883ec94dc4969e37054bdac8a085a5385285b6572ed9bbd51cb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7dbaf47e067289747ef65540a09c256f7427bf25eb4d315c43de820d75b4105ed0456c26e89bacc1b353c1ae715c13a0b773ca0673cd6a73cf44bfcc1835053"} 18:55:02 INFO - Running post-run listener: copy_logs_to_upload_dir 18:55:02 INFO - Copying logs to upload dir... 18:55:02 INFO - mkdir: /builds/slave/test/build/upload/logs 18:55:02 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.674611 ========= master_lag: 0.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-25 18:55:02.734405) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 18:55:02.738899) ========= 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.cXcwYnKK4w/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.jdS7eBJWeD/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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/Fx-Team/sha512/c54b960cd08508877353590b3425757697af99371b9d2cd5c0cfafefc435bcf32105b3a7b910883ec94dc4969e37054bdac8a085a5385285b6572ed9bbd51cb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7dbaf47e067289747ef65540a09c256f7427bf25eb4d315c43de820d75b4105ed0456c26e89bacc1b353c1ae715c13a0b773ca0673cd6a73cf44bfcc1835053"} build_url:https://queue.taskcluster.net/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010540 build_url: 'https://queue.taskcluster.net/v1/task/M6lyarfHQtaYmkssFxSO0w/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/c54b960cd08508877353590b3425757697af99371b9d2cd5c0cfafefc435bcf32105b3a7b910883ec94dc4969e37054bdac8a085a5385285b6572ed9bbd51cb9", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/f7dbaf47e067289747ef65540a09c256f7427bf25eb4d315c43de820d75b4105ed0456c26e89bacc1b353c1ae715c13a0b773ca0673cd6a73cf44bfcc1835053"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-25 18:55:02.768792) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 18:55:02.769118) ========= 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.cXcwYnKK4w/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.jdS7eBJWeD/Listeners TMPDIR=/var/folders/5z/1cbw0knd0ls912sq61_r0_0400000w/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.005064 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-25 18:55:02.818613) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 18:55:02.818940) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-25 18:55:02.819364) ========= ========= Total master_lag: 0.39 =========