builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0179 starttime: 1458041781.03 results: success (0) buildid: 20160315024544 builduid: c37d226e25dc4eb7952834f700a4f803 revision: dd0baa33759d1246c7632750a570d085e695b670 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 04:36:21.033436) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-15 04:36:21.033885) ========= ========= Started set props: basedir (results: 0, elapsed: 12 secs) (at 2016-03-15 04:36:21.034171) ========= 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.yoE1R4uIio/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.e1ydnp1MK6/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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.005769 basedir: '/builds/slave/test' ========= master_lag: 12.87 ========= ========= Finished set props: basedir (results: 0, elapsed: 12 secs) (at 2016-03-15 04:36:33.908996) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 19 secs) (at 2016-03-15 04:36:33.909271) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 19 secs) (at 2016-03-15 04:36:53.351476) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-03-15 04:36:53.351746) ========= 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.yoE1R4uIio/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.e1ydnp1MK6/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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.005408 ========= master_lag: 2.12 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 2 secs) (at 2016-03-15 04:36:55.473654) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 04:36:55.473934) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-15 04:36:55.474256) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 18 secs) (at 2016-03-15 04:36:55.474527) ========= 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.yoE1R4uIio/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.e1ydnp1MK6/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-15 04:36:56-- 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.54M=0.001s 2016-03-15 04:36:56 (8.54 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.594809 ========= master_lag: 18.21 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 18 secs) (at 2016-03-15 04:37:14.284002) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-15 04:37:14.284315) ========= 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.yoE1R4uIio/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.e1ydnp1MK6/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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.020001 ========= master_lag: 1.43 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 1 secs) (at 2016-03-15 04:37:15.729395) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2016-03-15 04:37:15.729698) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev dd0baa33759d1246c7632750a570d085e695b670 --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 dd0baa33759d1246c7632750a570d085e695b670 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yoE1R4uIio/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.e1ydnp1MK6/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-15 04:37:16,356 truncating revision to first 12 chars 2016-03-15 04:37:16,356 Setting DEBUG logging. 2016-03-15 04:37:16,356 attempt 1/10 2016-03-15 04:37:16,356 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/dd0baa33759d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-15 04:37:17,364 unpacking tar archive at: fx-team-dd0baa33759d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.255007 ========= master_lag: 7.90 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 9 secs) (at 2016-03-15 04:37:24.880511) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 04:37:24.883817) ========= echo dd0baa33759d1246c7632750a570d085e695b670 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'dd0baa33759d1246c7632750a570d085e695b670'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.yoE1R4uIio/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.e1ydnp1MK6/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 dd0baa33759d1246c7632750a570d085e695b670 program finished with exit code 0 elapsedTime=0.005096 script_repo_revision: 'dd0baa33759d1246c7632750a570d085e695b670' ========= master_lag: 0.93 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-15 04:37:25.823590) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 5 secs) (at 2016-03-15 04:37:25.823915) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 5 secs) (at 2016-03-15 04:37:31.681059) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-15 04:37:31.681567) ========= /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.yoE1R4uIio/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.e1ydnp1MK6/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 04:37:31 INFO - MultiFileLogger online at 20160315 04:37:31 in /builds/slave/test 04:37:31 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 04:37:31 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:37:31 INFO - {'append_to_log': False, 04:37:31 INFO - 'base_work_dir': '/builds/slave/test', 04:37:31 INFO - 'blob_upload_branch': 'Fx-Team', 04:37:31 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:37:31 INFO - 'branch': 'Fx-Team', 04:37:31 INFO - 'buildbot_json_path': 'buildprops.json', 04:37:31 INFO - 'config_files': ('talos/mac_config.py',), 04:37:31 INFO - 'default_actions': ('clobber', 04:37:31 INFO - 'read-buildbot-config', 04:37:31 INFO - 'download-and-extract', 04:37:31 INFO - 'populate-webroot', 04:37:31 INFO - 'create-virtualenv', 04:37:31 INFO - 'install', 04:37:31 INFO - 'run-tests'), 04:37:31 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:37:31 INFO - 'download_minidump_stackwalk': True, 04:37:31 INFO - 'download_symbols': 'ondemand', 04:37:31 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:37:31 INFO - 'tooltool.py': '/tools/tooltool.py', 04:37:31 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:37:31 INFO - '/tools/misc-python/virtualenv.py')}, 04:37:31 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:37:31 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:37:31 INFO - 'installer_path': 'installer.exe', 04:37:31 INFO - 'log_level': 'info', 04:37:31 INFO - 'log_name': 'talos', 04:37:31 INFO - 'log_to_console': True, 04:37:31 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:37:31 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:37:31 INFO - 'opt_config_files': (), 04:37:31 INFO - 'pip_index': False, 04:37:31 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:37:31 INFO - 'cmd': ('bash', 04:37:31 INFO - '-c', 04:37:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:37:31 INFO - 'enabled': True, 04:37:31 INFO - 'halt_on_failure': False, 04:37:31 INFO - 'name': 'check_screen_resolution'},), 04:37:31 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:37:31 INFO - 'cmd': ('bash', 04:37:31 INFO - '-c', 04:37:31 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:37:31 INFO - 'enabled': True, 04:37:31 INFO - 'halt_on_failure': False, 04:37:31 INFO - 'name': 'check_screen_resolution'},), 04:37:31 INFO - 'run_cmd_checks_enabled': True, 04:37:31 INFO - 'sps_profile': False, 04:37:31 INFO - 'sps_profile_interval': 0, 04:37:31 INFO - 'suite': 'dromaeojs', 04:37:31 INFO - 'system_bits': '32', 04:37:31 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:37:31 INFO - 'title': 't-yosemite-r7-0179', 04:37:31 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:37:31 INFO - 'use_talos_json': True, 04:37:31 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:37:31 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:37:31 INFO - 'work_dir': 'build'} 04:37:31 INFO - ##### 04:37:31 INFO - ##### Running clobber step. 04:37:31 INFO - ##### 04:37:31 INFO - Running pre-action listener: _resource_record_pre_action 04:37:31 INFO - Running main action method: clobber 04:37:31 INFO - rmtree: /builds/slave/test/build 04:37:31 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:37:33 INFO - Running post-action listener: _resource_record_post_action 04:37:33 INFO - ##### 04:37:33 INFO - ##### Running read-buildbot-config step. 04:37:33 INFO - ##### 04:37:33 INFO - Running pre-action listener: _resource_record_pre_action 04:37:33 INFO - Running main action method: read_buildbot_config 04:37:33 INFO - Using buildbot properties: 04:37:33 INFO - { 04:37:33 INFO - "project": "", 04:37:33 INFO - "product": "firefox", 04:37:33 INFO - "script_repo_revision": "production", 04:37:33 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 04:37:34 INFO - "repository": "", 04:37:34 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 04:37:34 INFO - "buildid": "20160315024544", 04:37:34 INFO - "pgo_build": "False", 04:37:34 INFO - "basedir": "/builds/slave/test", 04:37:34 INFO - "buildnumber": 586, 04:37:34 INFO - "slavename": "t-yosemite-r7-0179", 04:37:34 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:37:34 INFO - "platform": "yosemite_r7", 04:37:34 INFO - "scheduler": "tests-fx-team-macosx64-talos", 04:37:34 INFO - "branch": "fx-team", 04:37:34 INFO - "repo_path": "integration/fx-team", 04:37:34 INFO - "revision": "dd0baa33759d1246c7632750a570d085e695b670", 04:37:34 INFO - "stage_platform": "macosx64", 04:37:34 INFO - "builduid": "c37d226e25dc4eb7952834f700a4f803", 04:37:34 INFO - "slavebuilddir": "test" 04:37:34 INFO - } 04:37:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 04:37:34 INFO - Running post-action listener: _resource_record_post_action 04:37:34 INFO - ##### 04:37:34 INFO - ##### Running download-and-extract step. 04:37:34 INFO - ##### 04:37:34 INFO - Running pre-action listener: _resource_record_pre_action 04:37:34 INFO - Running main action method: download_and_extract 04:37:34 INFO - mkdir: /builds/slave/test/build/tests 04:37:34 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')]} 04:37:34 INFO - https://queue.taskcluster.net/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:37:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:37:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 04:37:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/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 04:37:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/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 04:37:36 INFO - Downloaded 1199 bytes. 04:37:36 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 04:37:36 INFO - Using the following test package requirements: 04:37:36 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:37:36 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:36 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 04:37:36 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:36 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 04:37:36 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:36 INFO - u'jsshell-mac.zip'], 04:37:36 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:36 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 04:37:36 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 04:37:36 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:36 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 04:37:36 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:36 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 04:37:36 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:36 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 04:37:36 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 04:37:36 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 04:37:36 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:37:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:36 INFO - https://queue.taskcluster.net/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:37:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:37:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:37:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/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 04:37:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/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 04:37:37 INFO - Downloaded 17853373 bytes. 04:37:37 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'] 04:37:37 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 04:37:40 INFO - Return code: 0 04:37:40 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 04:37:40 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')]} 04:37:40 INFO - https://queue.taskcluster.net/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:37:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:37:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 04:37:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/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 04:37:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/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 04:37:42 INFO - Downloaded 17853373 bytes. 04:37:42 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'] 04:37:42 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 04:37:45 INFO - Return code: 0 04:37:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:37:45 INFO - https://queue.taskcluster.net/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:37:45 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:37:45 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 04:37:45 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/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 04:37:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/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 04:37:46 INFO - Downloaded 10845263 bytes. 04:37:46 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'] 04:37:46 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 04:37:46 INFO - Return code: 0 04:37: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')]} 04:37:46 INFO - https://queue.taskcluster.net/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:37:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:37:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:37:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 04:37:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/OD231tgdRiq8_LPGTqKcPw/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 04:37:51 INFO - Downloaded 111185673 bytes. 04:37:51 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:37:51 INFO - mkdir: /builds/slave/test/properties 04:37:51 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:37:51 INFO - Writing to file /builds/slave/test/properties/build_url 04:37:51 INFO - Contents: 04:37:51 INFO - build_url:https://queue.taskcluster.net/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 04:37:52 INFO - Running post-action listener: _resource_record_post_action 04:37:52 INFO - Running post-action listener: set_extra_try_arguments 04:37:52 INFO - ##### 04:37:52 INFO - ##### Running populate-webroot step. 04:37:52 INFO - ##### 04:37:52 INFO - Running pre-action listener: _resource_record_pre_action 04:37:52 INFO - Running main action method: populate_webroot 04:37:52 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:37:52 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:37:52 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:37:52 INFO - '--tppagecycles', 04:37:52 INFO - '7'], 04:37:52 INFO - 'tests': ['tsvgm']}}, 04:37:52 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:37:52 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:37:52 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:37:52 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:37:52 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:37:52 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:37:52 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:52 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:52 INFO - 'talos_options': ['--e10s'], 04:37:52 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:37:52 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:52 INFO - 'tests': ['damp', 'tps']}, 04:37:52 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:52 INFO - 'talos_options': ['--e10s'], 04:37:52 INFO - 'tests': ['damp', 'tps']}, 04:37:52 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:37:52 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:37:52 INFO - 'other': {'tests': ['a11yr', 04:37:52 INFO - 'ts_paint', 04:37:52 INFO - 'tpaint', 04:37:52 INFO - 'sessionrestore', 04:37:52 INFO - 'sessionrestore_no_auto_restore', 04:37:52 INFO - 'tabpaint']}, 04:37:52 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:37:52 INFO - 'tests': ['a11yr', 04:37:52 INFO - 'ts_paint', 04:37:52 INFO - 'tpaint', 04:37:52 INFO - 'sessionrestore', 04:37:52 INFO - 'sessionrestore_no_auto_restore', 04:37:52 INFO - 'tabpaint']}, 04:37:52 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:37:52 INFO - 'tests': ['a11yr', 04:37:52 INFO - 'ts_paint', 04:37:52 INFO - 'tpaint', 04:37:52 INFO - 'sessionrestore', 04:37:52 INFO - 'sessionrestore_no_auto_restore', 04:37:52 INFO - 'tabpaint']}, 04:37:52 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:37:52 INFO - 'tests': ['a11yr', 04:37:52 INFO - 'ts_paint', 04:37:52 INFO - 'tpaint', 04:37:52 INFO - 'sessionrestore', 04:37:52 INFO - 'sessionrestore_no_auto_restore', 04:37:52 INFO - 'tabpaint']}, 04:37:52 INFO - 'other_l64': {'tests': ['a11yr', 04:37:52 INFO - 'ts_paint', 04:37:52 INFO - 'tpaint', 04:37:52 INFO - 'sessionrestore', 04:37:52 INFO - 'sessionrestore_no_auto_restore', 04:37:52 INFO - 'tabpaint']}, 04:37:52 INFO - 'other_nol64': {'tests': ['a11yr', 04:37:52 INFO - 'ts_paint', 04:37:52 INFO - 'tpaint', 04:37:52 INFO - 'sessionrestore', 04:37:52 INFO - 'sessionrestore_no_auto_restore', 04:37:52 INFO - 'tabpaint']}, 04:37:52 INFO - 'svgr': {'tests': ['tsvgx', 04:37:52 INFO - 'tsvgr_opacity', 04:37:52 INFO - 'tart', 04:37:52 INFO - 'tscrollx', 04:37:52 INFO - 'cart']}, 04:37:52 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:37:52 INFO - 'tests': ['tsvgx', 04:37:52 INFO - 'tsvgr_opacity', 04:37:52 INFO - 'tart', 04:37:52 INFO - 'tscrollx', 04:37:52 INFO - 'cart']}, 04:37:52 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:52 INFO - 'tests': ['tp5o']}, 04:37:52 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:52 INFO - 'talos_options': ['--e10s'], 04:37:52 INFO - 'tests': ['tp5o']}, 04:37:52 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:52 INFO - 'talos_options': ['--xperf_path', 04:37:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:52 INFO - 'tests': ['tp5n']}, 04:37:52 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:37:52 INFO - 'talos_options': ['--e10s', 04:37:52 INFO - '--xperf_path', 04:37:52 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:37:52 INFO - 'tests': ['tp5n']}}, 04:37:52 INFO - 'talos.zip': {'path': '', 04:37:52 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:37:52 INFO - Running post-action listener: _resource_record_post_action 04:37:52 INFO - ##### 04:37:52 INFO - ##### Running create-virtualenv step. 04:37:52 INFO - ##### 04:37:52 INFO - Running pre-action listener: _resource_record_pre_action 04:37:52 INFO - Running main action method: create_virtualenv 04:37:52 INFO - Creating virtualenv /builds/slave/test/build/venv 04:37:52 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 04:37:52 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:37:52 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:37:52 INFO - Using real prefix '/tools/python27' 04:37:52 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:37:53 INFO - Installing distribute.............................................................................................................................................................................................done. 04:37:56 INFO - Installing pip.................done. 04:37:56 INFO - Return code: 0 04:37:56 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:37:56 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')]} 04:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:56 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')]} 04:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:56 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 0x110625a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11062d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96f1c9c210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104c9d30>, '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 0x1102eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104c0b20>, '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.yoE1R4uIio/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.e1ydnp1MK6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 04:37:56 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 04:37:56 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 04:37:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yoE1R4uIio/Render', 04:37:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:56 INFO - 'HOME': '/Users/cltbld', 04:37:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:56 INFO - 'LOGNAME': 'cltbld', 04:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:56 INFO - 'MOZ_NO_REMOTE': '1', 04:37:56 INFO - 'NO_EM_RESTART': '1', 04:37:56 INFO - 'PAGER': '/bin/cat', 04:37:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:56 INFO - 'PWD': '/builds/slave/test', 04:37:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:56 INFO - 'SHELL': '/bin/bash', 04:37:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1ydnp1MK6/Listeners', 04:37:56 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 04:37:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:56 INFO - 'USER': 'cltbld', 04:37:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:56 INFO - 'XPC_FLAGS': '0x0', 04:37:56 INFO - 'XPC_SERVICE_NAME': '0', 04:37:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:56 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 04:37:56 INFO - Cleaning up... 04:37:56 INFO - Return code: 0 04:37:56 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:37:56 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')]} 04:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:37:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:56 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')]} 04:37:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:37:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:37:56 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 0x110625a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11062d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96f1c9c210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104c9d30>, '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 0x1102eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104c0b20>, '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.yoE1R4uIio/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.e1ydnp1MK6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 04:37:56 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 04:37:56 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 04:37:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yoE1R4uIio/Render', 04:37:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:56 INFO - 'HOME': '/Users/cltbld', 04:37:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:56 INFO - 'LOGNAME': 'cltbld', 04:37:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:56 INFO - 'MOZ_NO_REMOTE': '1', 04:37:56 INFO - 'NO_EM_RESTART': '1', 04:37:56 INFO - 'PAGER': '/bin/cat', 04:37:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:56 INFO - 'PWD': '/builds/slave/test', 04:37:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:56 INFO - 'SHELL': '/bin/bash', 04:37:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1ydnp1MK6/Listeners', 04:37:56 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 04:37:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:56 INFO - 'USER': 'cltbld', 04:37:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:56 INFO - 'XPC_FLAGS': '0x0', 04:37:56 INFO - 'XPC_SERVICE_NAME': '0', 04:37:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:37:56 INFO - Downloading/unpacking psutil>=0.7.1 04:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:37:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:37:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:37:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:37:59 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:37:59 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:37:59 INFO - Installing collected packages: psutil 04:37:59 INFO - Running setup.py install for psutil 04:37:59 INFO - building 'psutil._psutil_osx' extension 04:37:59 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 04:38:00 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 04:38:00 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 04:38:00 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 04:38:00 INFO - building 'psutil._psutil_posix' extension 04:38:00 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 04:38:00 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:38:00 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:38:00 INFO - ^ 04:38:00 INFO - 1 warning generated. 04:38:00 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 04:38:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:38:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:38:00 INFO - Successfully installed psutil 04:38:00 INFO - Cleaning up... 04:38:00 INFO - Return code: 0 04:38:00 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:38: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')]} 04:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38: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')]} 04:38:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110625a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11062d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96f1c9c210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104c9d30>, '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 0x1102eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104c0b20>, '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.yoE1R4uIio/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.e1ydnp1MK6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 04:38:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:38:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:38:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yoE1R4uIio/Render', 04:38:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:00 INFO - 'HOME': '/Users/cltbld', 04:38:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:00 INFO - 'LOGNAME': 'cltbld', 04:38:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:00 INFO - 'MOZ_NO_REMOTE': '1', 04:38:00 INFO - 'NO_EM_RESTART': '1', 04:38:00 INFO - 'PAGER': '/bin/cat', 04:38:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:00 INFO - 'PWD': '/builds/slave/test', 04:38:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:00 INFO - 'SHELL': '/bin/bash', 04:38:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1ydnp1MK6/Listeners', 04:38:00 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 04:38:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:00 INFO - 'USER': 'cltbld', 04:38:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:00 INFO - 'XPC_FLAGS': '0x0', 04:38:00 INFO - 'XPC_SERVICE_NAME': '0', 04:38:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:00 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:01 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 04:38:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:38:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:38:03 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:38:03 INFO - Installing collected packages: mozsystemmonitor 04:38:03 INFO - Running setup.py install for mozsystemmonitor 04:38:03 INFO - Successfully installed mozsystemmonitor 04:38:03 INFO - Cleaning up... 04:38:03 INFO - Return code: 0 04:38:03 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:38:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x110625a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11062d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96f1c9c210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104c9d30>, '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 0x1102eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104c0b20>, '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.yoE1R4uIio/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.e1ydnp1MK6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 04:38:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:38:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:38:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yoE1R4uIio/Render', 04:38:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:03 INFO - 'HOME': '/Users/cltbld', 04:38:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:03 INFO - 'LOGNAME': 'cltbld', 04:38:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:03 INFO - 'MOZ_NO_REMOTE': '1', 04:38:03 INFO - 'NO_EM_RESTART': '1', 04:38:03 INFO - 'PAGER': '/bin/cat', 04:38:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:03 INFO - 'PWD': '/builds/slave/test', 04:38:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:03 INFO - 'SHELL': '/bin/bash', 04:38:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1ydnp1MK6/Listeners', 04:38:03 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 04:38:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:03 INFO - 'USER': 'cltbld', 04:38:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:03 INFO - 'XPC_FLAGS': '0x0', 04:38:03 INFO - 'XPC_SERVICE_NAME': '0', 04:38:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:03 INFO - Downloading/unpacking blobuploader==1.2.4 04:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:06 INFO - Downloading blobuploader-1.2.4.tar.gz 04:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:38:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:38:06 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:38:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:38:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:38:07 INFO - Downloading docopt-0.6.1.tar.gz 04:38:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:38:07 INFO - Installing collected packages: blobuploader, requests, docopt 04:38:07 INFO - Running setup.py install for blobuploader 04:38:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:38:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:38:07 INFO - Running setup.py install for requests 04:38:08 INFO - Running setup.py install for docopt 04:38:08 INFO - Successfully installed blobuploader requests docopt 04:38:08 INFO - Cleaning up... 04:38:08 INFO - Return code: 0 04:38:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:08 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')]} 04:38:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:08 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')]} 04:38:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:08 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 0x110625a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11062d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96f1c9c210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104c9d30>, '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 0x1102eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104c0b20>, '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.yoE1R4uIio/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.e1ydnp1MK6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 04:38:08 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 04:38:08 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 04:38:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yoE1R4uIio/Render', 04:38:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:08 INFO - 'HOME': '/Users/cltbld', 04:38:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:08 INFO - 'LOGNAME': 'cltbld', 04:38:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:08 INFO - 'MOZ_NO_REMOTE': '1', 04:38:08 INFO - 'NO_EM_RESTART': '1', 04:38:08 INFO - 'PAGER': '/bin/cat', 04:38:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:08 INFO - 'PWD': '/builds/slave/test', 04:38:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:08 INFO - 'SHELL': '/bin/bash', 04:38:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1ydnp1MK6/Listeners', 04:38:08 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 04:38:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:08 INFO - 'USER': 'cltbld', 04:38:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:08 INFO - 'XPC_FLAGS': '0x0', 04:38:08 INFO - 'XPC_SERVICE_NAME': '0', 04:38:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:38:08 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-NuZ3BO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:38:08 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-N3CjdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:38:08 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-8sIGOT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:38:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:38:08 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-AgENL0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:38:09 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-Kez7R2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:38:09 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-PFvQmq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:09 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-JOuypf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:09 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-XWn853-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:09 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-pAgbP4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:09 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-HuHTjY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:09 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-naABQF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:09 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-iQwWs0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:09 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-1ObTOE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:09 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-smhWI0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:10 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-KXNRT2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:10 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-eR_08I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:10 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-MxBmEq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:38:10 INFO - Running setup.py install for manifestparser 04:38:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:38:10 INFO - Running setup.py install for mozcrash 04:38:10 INFO - Running setup.py install for mozdebug 04:38:10 INFO - Running setup.py install for mozdevice 04:38:10 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:38:10 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:38:11 INFO - Running setup.py install for mozfile 04:38:11 INFO - Running setup.py install for mozhttpd 04:38:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:38:11 INFO - Running setup.py install for mozinfo 04:38:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:38:11 INFO - Running setup.py install for mozInstall 04:38:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:38:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:38:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:38:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:38:11 INFO - Running setup.py install for mozleak 04:38:11 INFO - Running setup.py install for mozlog 04:38:11 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:38:11 INFO - Running setup.py install for moznetwork 04:38:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:38:12 INFO - Running setup.py install for mozprocess 04:38:12 INFO - Running setup.py install for mozprofile 04:38:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:38:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:38:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:38:12 INFO - Running setup.py install for mozrunner 04:38:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:38:12 INFO - Running setup.py install for mozscreenshot 04:38:12 INFO - Running setup.py install for moztest 04:38:12 INFO - Running setup.py install for mozversion 04:38:12 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:38:12 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:38:12 INFO - Cleaning up... 04:38:12 INFO - Return code: 0 04:38:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:12 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')]} 04:38:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:12 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')]} 04:38:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:12 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 0x110625a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11062d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96f1c9c210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104c9d30>, '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 0x1102eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104c0b20>, '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.yoE1R4uIio/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.e1ydnp1MK6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 04:38:12 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 04:38:12 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 04:38:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yoE1R4uIio/Render', 04:38:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:12 INFO - 'HOME': '/Users/cltbld', 04:38:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:12 INFO - 'LOGNAME': 'cltbld', 04:38:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:12 INFO - 'MOZ_NO_REMOTE': '1', 04:38:12 INFO - 'NO_EM_RESTART': '1', 04:38:12 INFO - 'PAGER': '/bin/cat', 04:38:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:12 INFO - 'PWD': '/builds/slave/test', 04:38:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:12 INFO - 'SHELL': '/bin/bash', 04:38:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1ydnp1MK6/Listeners', 04:38:12 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 04:38:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:12 INFO - 'USER': 'cltbld', 04:38:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:12 INFO - 'XPC_FLAGS': '0x0', 04:38:12 INFO - 'XPC_SERVICE_NAME': '0', 04:38:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:38:13 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-pYdmzd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:38:13 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)) 04:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:38:13 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-1B9Rex-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:38:13 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)) 04:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:38:13 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-OY419a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:38:13 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)) 04:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:38:13 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-F1GmVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:38:13 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)) 04:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:38:13 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-EvZ7RL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:38:13 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)) 04:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:38:13 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-HyB5Xz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:38:13 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)) 04:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:38:13 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-A4kwwM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:38:13 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)) 04:38:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:38:13 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-fNUkqN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:38:14 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)) 04:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:38:14 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-UEOQrm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:38:14 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)) 04:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:38:14 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-eQpRmJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:38:14 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)) 04:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:38:14 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-HvgcwP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:38:14 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)) 04:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:38:14 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-ph8ffT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:38:14 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)) 04:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:38:14 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-IMddEE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:38:14 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)) 04:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:38:14 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-C4h5UP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:38:14 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)) 04:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:14 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-nFXFc2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:38:14 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)) 04:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:38:14 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-Oj2HMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:38:14 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)) 04:38:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:38:14 INFO - Running setup.py (path:/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/pip-UJJdfA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:38:15 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)) 04:38:15 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)) 04:38:15 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)) 04:38:15 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)) 04:38:15 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)) 04:38:15 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)) 04:38:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:38:15 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 04:38:15 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 04:38:15 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 04:38:15 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 04:38:15 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 04:38:15 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 04:38:17 INFO - Downloading blessings-1.6.tar.gz 04:38:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:38:17 INFO - Installing collected packages: blessings 04:38:17 INFO - Running setup.py install for blessings 04:38:17 INFO - Successfully installed blessings 04:38:17 INFO - Cleaning up... 04:38:17 INFO - Return code: 0 04:38:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:38:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:17 INFO - Reading from file tmpfile_stdout 04:38:17 INFO - Current package versions: 04:38:17 INFO - blessings == 1.6 04:38:17 INFO - blobuploader == 1.2.4 04:38:17 INFO - docopt == 0.6.1 04:38:17 INFO - manifestparser == 1.1 04:38:17 INFO - mozInstall == 1.12 04:38:17 INFO - mozcrash == 0.17 04:38:17 INFO - mozdebug == 0.1 04:38:17 INFO - mozdevice == 0.48 04:38:17 INFO - mozfile == 1.2 04:38:17 INFO - mozhttpd == 0.7 04:38:17 INFO - mozinfo == 0.9 04:38:17 INFO - mozleak == 0.1 04:38:17 INFO - mozlog == 3.1 04:38:17 INFO - moznetwork == 0.27 04:38:17 INFO - mozprocess == 0.22 04:38:17 INFO - mozprofile == 0.28 04:38:17 INFO - mozrunner == 6.11 04:38:17 INFO - mozscreenshot == 0.1 04:38:17 INFO - mozsystemmonitor == 0.0 04:38:17 INFO - moztest == 0.7 04:38:17 INFO - mozversion == 1.4 04:38:17 INFO - psutil == 3.1.1 04:38:17 INFO - requests == 1.2.3 04:38:17 INFO - wsgiref == 0.1.2 04:38:17 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:38:17 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')]} 04:38:17 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:17 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:17 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')]} 04:38:17 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:17 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:17 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 0x110625a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11062d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96f1c9c210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104c9d30>, '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 0x1102eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104c0b20>, '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.yoE1R4uIio/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.e1ydnp1MK6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 04:38:17 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 04:38:17 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 04:38:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yoE1R4uIio/Render', 04:38:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:17 INFO - 'HOME': '/Users/cltbld', 04:38:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:17 INFO - 'LOGNAME': 'cltbld', 04:38:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:17 INFO - 'MOZ_NO_REMOTE': '1', 04:38:17 INFO - 'NO_EM_RESTART': '1', 04:38:17 INFO - 'PAGER': '/bin/cat', 04:38:17 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:17 INFO - 'PWD': '/builds/slave/test', 04:38:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:17 INFO - 'SHELL': '/bin/bash', 04:38:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1ydnp1MK6/Listeners', 04:38:17 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 04:38:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:17 INFO - 'USER': 'cltbld', 04:38:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:17 INFO - 'XPC_FLAGS': '0x0', 04:38:17 INFO - 'XPC_SERVICE_NAME': '0', 04:38:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:18 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)) 04:38:18 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)) 04:38:18 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)) 04:38:18 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)) 04:38:18 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)) 04:38:18 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)) 04:38:18 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)) 04:38:18 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)) 04:38:18 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)) 04:38:18 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)) 04:38:18 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)) 04:38:18 INFO - Cleaning up... 04:38:18 INFO - Return code: 0 04:38:18 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:38:18 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')]} 04:38:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:18 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')]} 04:38:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38:18 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 0x110625a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11062d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96f1c9c210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104c9d30>, '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 0x1102eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104c0b20>, '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.yoE1R4uIio/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.e1ydnp1MK6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 04:38:18 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 04:38:18 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 04:38:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yoE1R4uIio/Render', 04:38:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:18 INFO - 'HOME': '/Users/cltbld', 04:38:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:18 INFO - 'LOGNAME': 'cltbld', 04:38:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:18 INFO - 'MOZ_NO_REMOTE': '1', 04:38:18 INFO - 'NO_EM_RESTART': '1', 04:38:18 INFO - 'PAGER': '/bin/cat', 04:38:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:18 INFO - 'PWD': '/builds/slave/test', 04:38:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:18 INFO - 'SHELL': '/bin/bash', 04:38:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1ydnp1MK6/Listeners', 04:38:18 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 04:38:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:18 INFO - 'USER': 'cltbld', 04:38:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:18 INFO - 'XPC_FLAGS': '0x0', 04:38:18 INFO - 'XPC_SERVICE_NAME': '0', 04:38:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:18 INFO - Downloading/unpacking jsonschema 04:38:18 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 04:38:18 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 04:38:18 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 04:38:18 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 04:38:18 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 04:38:18 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 04:38:20 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:38:20 INFO - Downloading/unpacking functools32 (from jsonschema) 04:38:20 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 04:38:20 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 04:38:20 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 04:38:20 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 04:38:20 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 04:38:20 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 04:38:21 INFO - Downloading functools32-3.2.3-2.tar.gz 04:38:21 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:38:21 INFO - warning: no files found matching '*.txt' 04:38:21 INFO - no previously-included directories found matching 'build' 04:38:21 INFO - no previously-included directories found matching 'dist' 04:38:21 INFO - no previously-included directories found matching '.git*' 04:38:21 INFO - Installing collected packages: jsonschema, functools32 04:38:21 INFO - Running setup.py install for functools32 04:38:21 INFO - warning: no files found matching '*.txt' 04:38:21 INFO - no previously-included directories found matching 'build' 04:38:21 INFO - no previously-included directories found matching 'dist' 04:38:21 INFO - no previously-included directories found matching '.git*' 04:38:21 INFO - Successfully installed jsonschema functools32 04:38:21 INFO - Cleaning up... 04:38:21 INFO - Return code: 0 04:38:21 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:38: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')]} 04:38:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:38:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38: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')]} 04:38:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:38:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:38: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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x110625a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x11062d4c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f96f1c9c210>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1104c9d30>, '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 0x1102eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104c0b20>, '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.yoE1R4uIio/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.e1ydnp1MK6/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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 04:38: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', 'flake8'] in /builds/slave/test/build 04:38: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 flake8 04:38:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yoE1R4uIio/Render', 04:38:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:38:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:38:21 INFO - 'HOME': '/Users/cltbld', 04:38:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:38:21 INFO - 'LOGNAME': 'cltbld', 04:38:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:38:21 INFO - 'MOZ_NO_REMOTE': '1', 04:38:21 INFO - 'NO_EM_RESTART': '1', 04:38:21 INFO - 'PAGER': '/bin/cat', 04:38:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:38:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:38:21 INFO - 'PWD': '/builds/slave/test', 04:38:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:38:21 INFO - 'SHELL': '/bin/bash', 04:38:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1ydnp1MK6/Listeners', 04:38:21 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 04:38:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:38:21 INFO - 'USER': 'cltbld', 04:38:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:38:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:38:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:38:21 INFO - 'XPC_FLAGS': '0x0', 04:38:21 INFO - 'XPC_SERVICE_NAME': '0', 04:38:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:38:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:38:21 INFO - Downloading/unpacking flake8 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:24 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:38:24 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:38:24 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 04:38:24 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 04:38:24 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 04:38:24 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 04:38:24 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 04:38:24 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 04:38:24 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:38:24 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:38:24 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 04:38:24 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 04:38:24 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 04:38:24 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 04:38:24 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 04:38:24 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 04:38:24 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:38:24 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 04:38:24 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 04:38: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 04:38: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 04:38: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 04:38: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 04:38:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:38:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:38:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:38:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:38:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:38:25 INFO - no previously-included directories found matching 'docs/_build' 04:38:25 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:38:25 INFO - Running setup.py install for pep8 04:38:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:38:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:38:25 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:38:25 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:38:25 INFO - no previously-included directories found matching 'docs/_build' 04:38:25 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:38:25 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:38:25 INFO - Cleaning up... 04:38:25 INFO - Return code: 0 04:38:25 INFO - Running post-action listener: _resource_record_post_action 04:38:25 INFO - Running post-action listener: _start_resource_monitoring 04:38:25 INFO - Starting resource monitoring. 04:38:25 INFO - ##### 04:38:25 INFO - ##### Running install step. 04:38:25 INFO - ##### 04:38:25 INFO - Running pre-action listener: _resource_record_pre_action 04:38:25 INFO - Running main action method: install 04:38:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:38:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:38:26 INFO - Reading from file tmpfile_stdout 04:38:26 INFO - Detecting whether we're running mozinstall >=1.0... 04:38:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:38:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:38:26 INFO - Reading from file tmpfile_stdout 04:38:26 INFO - Output received: 04:38:26 INFO - Usage: mozinstall [options] installer 04:38:26 INFO - Options: 04:38:26 INFO - -h, --help show this help message and exit 04:38:26 INFO - -d DEST, --destination=DEST 04:38:26 INFO - Directory to install application into. [default: 04:38:26 INFO - "/builds/slave/test"] 04:38:26 INFO - --app=APP Application being installed. [default: firefox] 04:38:26 INFO - mkdir: /builds/slave/test/build/application 04:38:26 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'] 04:38:26 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 04:39:00 INFO - Reading from file tmpfile_stdout 04:39:00 INFO - Output received: 04:39:00 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:39:00 INFO - Running post-action listener: _resource_record_post_action 04:39:00 INFO - ##### 04:39:00 INFO - ##### Running run-tests step. 04:39:00 INFO - ##### 04:39:00 INFO - Running pre-action listener: _resource_record_pre_action 04:39:00 INFO - Running main action method: run_tests 04:39:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:39:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:39:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:39:00 INFO - 2016-03-15 04:39:00.030 screenresolution[1941:18481] starting screenresolution argv=screenresolution get 04:39:00 INFO - 2016-03-15 04:39:00.033 screenresolution[1941:18481] Display 0: 1600x1200x32@60 04:39:00 INFO - 2016-03-15 04:39:00.039 screenresolution[1942:18483] starting screenresolution argv=screenresolution list 04:39:00 INFO - Available Modes on Display 0 04:39:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:39:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:39:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:39:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:39:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:39:00 INFO - Intel Iris: 04:39:00 INFO - Chipset Model: Intel Iris 04:39:00 INFO - Type: GPU 04:39:00 INFO - Bus: Built-In 04:39:00 INFO - VRAM (Dynamic, Max): 1536 MB 04:39:00 INFO - Vendor: Intel (0x8086) 04:39:00 INFO - Device ID: 0x0a2e 04:39:00 INFO - Revision ID: 0x0009 04:39:00 INFO - Displays: 04:39:00 INFO - Display: 04:39:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:39:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:39:00 INFO - Display Serial Number: 1600x1200 60 04:39:00 INFO - Main Display: Yes 04:39:00 INFO - Mirror: Off 04:39:00 INFO - Online: Yes 04:39:00 INFO - Rotation: Supported 04:39:00 INFO - Return code: 0 04:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:39:00 INFO - Python 2.7.3 04:39:00 INFO - Return code: 0 04:39:00 INFO - grabbing minidump binary from tooltool 04:39: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')]} 04:39:00 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 0x1104c9d30>, '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 0x1102eddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1104c0b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:39:00 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 04:39:00 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 04:39:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:39:00 INFO - Return code: 0 04:39:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:39:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:39:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:39:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:39:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:39:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:39:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:39:01 INFO - Return code: 0 04:39:01 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/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0179', '--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 04:39:01 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/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0179 --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 04:39:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.yoE1R4uIio/Render', 04:39:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:39:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:39:01 INFO - 'HOME': '/Users/cltbld', 04:39:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:39:01 INFO - 'LOGNAME': 'cltbld', 04:39:01 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:39:01 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:39:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:39:01 INFO - 'MOZ_NO_REMOTE': '1', 04:39:01 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:39:01 INFO - 'NO_EM_RESTART': '1', 04:39:01 INFO - 'PAGER': '/bin/cat', 04:39:01 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:39:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:39:01 INFO - 'PWD': '/builds/slave/test', 04:39:01 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:39:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:39:01 INFO - 'SHELL': '/bin/bash', 04:39:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.e1ydnp1MK6/Listeners', 04:39:01 INFO - 'TMPDIR': '/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/', 04:39:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:39:01 INFO - 'USER': 'cltbld', 04:39:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:39:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:39:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:39:01 INFO - 'XPC_FLAGS': '0x0', 04:39:01 INFO - 'XPC_SERVICE_NAME': '0', 04:39:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:39:01 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/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0179', '--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 04:39:01 INFO - mozversion application_buildid: 20160315024544 04:39:01 INFO - mozversion application_changeset: dd0baa33759d1246c7632750a570d085e695b670 04:39:01 INFO - mozversion application_display_name: Nightly 04:39:01 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:39:01 INFO - mozversion application_name: Firefox 04:39:01 INFO - mozversion application_remotingname: firefox 04:39:01 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 04:39:01 INFO - mozversion application_vendor: Mozilla 04:39:01 INFO - mozversion application_version: 48.0a1 04:39:01 INFO - mozversion platform_buildid: 20160315024544 04:39:01 INFO - mozversion platform_changeset: dd0baa33759d1246c7632750a570d085e695b670 04:39:01 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 04:39:01 INFO - mozversion platform_version: 48.0a1 04:39:01 INFO - using testdate: 1458041941 04:39:01 INFO - actual date: 1458041941 04:39:01 INFO - starting webserver on 'localhost:57300' 04:39:01 INFO - SUITE-START | Running 2 tests 04:39:01 INFO - TEST-START | dromaeo_css 04:39:01 INFO - operating with platform_type : mac_ 04:39:01 INFO - Initialising browser for dromaeo_css test... 04:39:01 INFO - TEST-INFO | started process 1960 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmpGbrCYz/profile http://localhost:57300/getInfo.html) 04:39:04 INFO - PROCESS | 1960 | __metrics Screen width/height:1600/1200 04:39:04 INFO - PROCESS | 1960 | colorDepth:24 04:39:04 INFO - PROCESS | 1960 | Browser inner width/height: 1024/689 04:39:04 INFO - PROCESS | 1960 | __metrics 04:39:04 INFO - PROCESS | 1960 | 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" 04:39:04 ERROR - PROCESS | 1960 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:39:04 INFO - TEST-INFO | 1960: exit 0 04:39:04 INFO - Browser initialized. 04:39:04 INFO - Running cycle 1/1 for dromaeo_css test... 04:39:04 INFO - TEST-INFO | started process 1963 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmpGbrCYz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:39:16 INFO - PROCESS | 1963 | RSS: Main: 243449856 04:39:16 INFO - PROCESS | 1963 | 04:40:08 INFO - PROCESS | 1963 | 1458042008042 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] 04:42:18 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57300/tests/dromaeo/cssquery-dojo.html (next: http://localhost:57300/tests/dromaeo/cssquery-ext.html) 04:42:19 INFO - PROCESS | 1963 | RSS: Main: 356864000 04:42:19 INFO - PROCESS | 1963 | 04:45:22 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57300/tests/dromaeo/cssquery-ext.html (next: http://localhost:57300/tests/dromaeo/cssquery-jquery.html) 04:45:22 INFO - PROCESS | 1963 | RSS: Main: 378818560 04:45:22 INFO - PROCESS | 1963 | 04:48:24 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57300/tests/dromaeo/cssquery-jquery.html (next: http://localhost:57300/tests/dromaeo/cssquery-mootools.html) 04:48:25 INFO - PROCESS | 1963 | RSS: Main: 378187776 04:48:25 INFO - PROCESS | 1963 | 04:51:27 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57300/tests/dromaeo/cssquery-mootools.html (next: http://localhost:57300/tests/dromaeo/cssquery-prototype.html) 04:51:28 INFO - PROCESS | 1963 | RSS: Main: 335212544 04:51:28 INFO - PROCESS | 1963 | 04:54:31 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57300/tests/dromaeo/cssquery-prototype.html (next: http://localhost:57300/tests/dromaeo/cssquery-yui.html) 04:54:31 INFO - PROCESS | 1963 | RSS: Main: 337154048 04:54:31 INFO - PROCESS | 1963 | 04:57:34 INFO - PROCESS | 1963 | Cycle 1(1): loaded http://localhost:57300/tests/dromaeo/cssquery-yui.html (next: http://localhost:57300/tests/dromaeo/cssquery-dojo.html) 04:57:34 INFO - PROCESS | 1963 | RSS: Main: 407371776 04:57:34 INFO - PROCESS | 1963 | 04:57:34 INFO - PROCESS | 1963 | __start_tp_report 04:57:34 INFO - PROCESS | 1963 | _x_x_mozilla_page_load 04:57:34 INFO - PROCESS | 1963 | _x_x_mozilla_page_load_details 04:57:34 INFO - PROCESS | 1963 | |i|pagename|runs| 04:57:34 INFO - PROCESS | 1963 | |0;dojo.html;3151.3382189740155;3414.095264754839;3443.69006789389;3469.7224222062237;3483.460063690129;5514.972425137878;5515.33815942087;5538.7784488620455;5549.556035517164;5578.386377498472;4426.756528390937;5519.503244707976;5567.3040869891265;5570.359408668004;5604.719764011804;5071.061853557086;5074.314967479399;5101.846944591668;5172.09488339541;5180.533751962323;5122.308488354061;5161.122609156434;5181.533661970422;5195.922061169085;5207.895842083156;5127.077126117298;5150.2532132840715;5188.844334669947;5189.532942035216;5194.688318700871;5114.820981265657;5155.639105262614;5156.278121063016;5161.200013997799;5201;5000.524950129732;5058.038972595195;5079.4412614612365;5081.618878584121;5099.949000509984;4152.979235103805;5400.756965936543;5461.126219804852;5486;5571.526420254283;6135.417135372132;6141.78503752371;6144.5084393248435;6149.13912052313;6165;6114.327423983358;6118.418750218722;6198.380161983766;6246.875562398766;6264.279607845065;5662.009148399014;5696.316442026942;5711.7144142792695;5716.514096301861;5736.282964629421;6302.936970630235;6336.841578960563;6338.556301058974;6341.3341599132345;6350.142730731384;5914.497267732291;6016.127661489059;6074.028155495188;6080.027195648675;6113.480354169857;6159.538034647419;6182.845428864314;6212.9068063979075;6219.160413344141;6233.75064997395;6149.2313460817395;6161.322254551996;6165.32181460039;6169.105479705508;6179;6025.789097381658;6093.111789665744;6116.235470566179;6195.597286176474;6226.813195604139;4787.281907713871;4804.2073057945745;4809.519048095232;4817.855464336076;4835.879103022453;4294.935575966363;4304.8161755517485;4306.504751953503;4320.503142138631;4374.21264172452;5550.69471179089;5638.295213098363;5724.627899186539;5742.483176514133;5742.59801813869;6157.291911430153;6164.938350616526;6180.47465965398;6188.0717892315615;6193.349698281616;4813.422389313305;5659.886802263932;5732.426757324234;5735.483806457439;5740.971295143498;5297.470252974672;5312.946870531246;5319.069162896478;5341;5353.7055461949185;5232.502912223333;6293.118963345135;6295.842603934847;6300.7479700811455;6322.936770632419;6108.633481991094;6150.261968563801;6238.532110091671;6242.157308763259;6267.279262884645;6282.528810339151;6284.4344009039405;6284.717187726655;6292.087647291209;6298.496120310272;6082.300535438481;6095.969520152371;6109.961306577804;6113.663748493697;6115.990861507801;4748.715077095385;6152;6166.599171053867;6186.041163619646;6244.687765611792;4841.394825646794;5995.46040856325;6031.185789918481;6039;6041.486473649789;4790.257510085942;5944.227250457413;5950.494207992196;5978.282606087298;5978.910316345346;5738.942610573841;5803.419658034163;5845.532357411312;5884;5941.346451890375;5024.969881174424;5906;5983.730732117152;5992.970035149797;6038.969805151122;5690.032694442038;5765.798197063083;5779.422057794187;5832.12518122285;5832.679202643895 04:57:34 INFO - PROCESS | 1963 | |1;ext.html;456.6940150099433;562.7608266486742;583.5564970622329;622.6668732228258;631.6525910749087;23327.066917323307;37211.25577488452;37310.25379492409;37377.62622373775;37447.251054978886;33206.33587328252;41472;41476.963075923115;41500.37749433761;41672.95817604554;9382.483963381994;9627.13355797978;9628.807423851518;9635.951820240889;9647.614095436174;9459.763505912339;9551.235901127893;9556.283278754086;9587.760305992371;9632.325737198398;9594.712158635251;9779.022097790199;9792.314537982344;9793.069658382443;9794.902050979506;9668.661596844111;9765.511724413751;9775.071368220008;9776.51117444132;9786.804263914717;8367.539785311805;9559.187469065138;9596.808063838755;9667.70996870095;9670.419774813463;39347.8032609838;39737.40393894094;39924.800375998224;39957;40039.59960400388;3131.7964332318325;3172.12766489215;3172.159377764894;3207.4226639204935;3387.1024178592693;29491.262718431997;29928.401431971455;31244.375112497622;31285.530717039263;31318.06045818629;2681.6916054653575;2705.3236690827293;2830.8584570771377;2848.1455563331124;2852.4009957908866;392122;394712;395093;395307;396270;68469;68537.65731171312;69646.65176674085;69882.30117698859;69924.65037674778;74458;75061.62469187619;75264.24735752572;75281.6235918817;75369.86945195826;17420.47738567845;17530.561735956704;17533.298668053136;17581.296748130186;18001.639967200583;13432.798508022388;13455.865441345657;13468.057235993583;13491.797623035662;13527.594172174851;18254.45236642903;22155.667664985038;22743.886280568822;22771.772282277296;22825.657615135788;8020.398470114648;8784.560771961376;9580.233581313478;10257.230707696952;10267.229957753198;918.2470374293149;918.2562124679031;992.3252188511881;1034.5809946971488;1058.25921854702;28606.71393286082;28798.280042999093;29086.563701544495;29530.409391812474;29592.260193494905;1003.9397636141855;1024.8770147582188;1076.741582020325;1179.0626451970704;1267.6387229639508;12792.84864362212;14996.475123370848;15634.905556611155;15735.606609834846;15773.369065237492;449866;454071.9706438208;454315;455632.66204027866;455698;56194;56598;56603.15095273574;56634;56798;1288.890444312244;1422.502124256502;1452.4045141491938;1455.6943041961306;1584.2949887300272;27962.86018569894;28059.859700701367;28606.570901436913;28688.709008095102;28798.256226690395;45229.321560175966;45777;45821.85445363892;45845.77077114727;45940.310895337265;263435;329845;330520;331232;331998;22293;27958.72041279561;27961.580576290966;31367.21581960469;31573.52639710452;33771.493427599096;38281.80859095687;39321.80339098286;39359.40960885532;39507;32789.83605081959;33344.99965001054;33384;34047.82976085104;34305.82847085749;33059.33881322408;33345.99962001144;33366.499502506995;33401;33828.15429614279;32716.67283327136;33406.83296583501;33433.49849752304;33454.33091338111;33727.15682107967;29642;30444.543331849596;30452.41154501892;30491;30624.693753063075;19580.216791328756;20479.38561843147;23511.29466116019;23716.169934052225;23925 04:57:34 INFO - PROCESS | 1963 | |2;jquery.html;359.3441968407655;359.6493418916556;361.126074898745;363.8471841826433;369.76704676054084;15524.767128493082;19633.803661963375;20926.476838079056;20944.371668849923;20954.952252387357;20020.0990955407;20389.878556679378;20931.37205883822;21211.151553937823;21244.93775311236;5807.0998995155815;5937.317208521011;5973.432523910222;6024.9698751506185;6028.4272994065495;4220.324748040314;4489.955100449003;5989;6500.382463665944;6542.574732642387;5498.45015498449;5567.944320556803;6345;6398.488120950313;6443.226812782473;6278.246610406734;6319.178506794134;6417.0695249189075;6447.451966582846;6474.546781725281;5589.161625756128;5606.383297837235;5613.382527921925;5627.409122042209;5627.521660658849;24433.755662443327;25544.36139096519;25924.611130832865;25983.740162598322;25991.74008259931;2060.5981833542464;2161.9783802161933;2181.727284089489;2240.439890027493;2516.496700659857;9470;9696.70909872705;9895.307328487008;9974.451405172713;14220.92889535556;1752.4304601004724;1808.9547761305942;1818.6635472437642;1861.6410020684975;1923.249932526316;69442.65278673625;70353.64823175903;82947;92725;102113.4894325531;10115.482677598418;10381.480925953672;11084.61203857861;11248.156388270912;11324.207305488537;13507;13547.119437236548;13563.796543051862;13564.389602467716;13613.931930340284;8442.480353536423;8675.56622168889;8675.566221689016;8744.69393571222;8790.780230494162;8811.779705507413;8833.911660883308;8852.645894164161;8936.955315223382;8963;4442.555744425532;4504.6396288296855;4511.548845115462;4544.386507821402;4556.931646025312;1709.3077303692025;1772.335374234662;1829.378011476078;1889.0932352470616;1896.0993528074055;698.5110422704128;767.8118860879121;901.7745563609097;936.6768464879606;1019.0573719309609;15085.849141508445;18110.456686299432;20096.799032009785;20313.289034884005;20706;959.5154447004218;969.6606187834343;973.250597040275;978.3445091788519;1018.7962407518378;10597.258191926645;11077.681337278887;11137.99758021782;11147.72130696739;11184.832227516432;602523;602862;607561;617743;619827;112364;112603;112896;114372;115557.6888462226;1020.3163880200284;1029.5881647340973;1050.175612144463;1050.9579616815242;1053.0995998421392;17772.377966771102;17815.73276400829;18035.0080745555;18425.53936151607;18472.445826625222;36097.63902360943;47790.761046194544;47962;48082.27876581924;48315.5168448311;68400;68527.3147268521;68542.31457685558;69712.60574788577;70695.64652176706;6569.37590928861;6963.373296403145;7235.421166306788;7663.118741344594;7990.081140668665;10909.290896091728;11978.981786547893;12087.214331068453;12241.632751017483;12282.938585307016;8638.91361086381;10380.740481488023;10532.315399499008;10643.840342394715;10786.352818830896;8206.671733130608;9963.850542241727;10444.007819257158;10483.318584291997;10540.9986051325;10615.256932014685;10858.782824343627;10964.671059868217;10991.725206869573;11075.556977721124;6181.289151747606;7548.1697013329585;7616.124145723313;7709.884351734616;7938.206179382016;9241.861372079558;10548.841767373342;10555.472226388803;10805.837912431478;10821.67534973952 04:57:34 INFO - PROCESS | 1963 | |3;mootools.html;1433.3478267388339;1570.4189449903538;1605.3097168217669;1883.5385330594006;2018.4045706516577;7905.881411778821;8413.453125546843;8535.445196062252;8554.786130346745;8555.10171432;8277.296429803473;8580.356473264514;8581.656733730642;8584.270337021346;8591.625339945609;2181.825453963679;2406.362313986795;2453.8159638027173;2475.7276699563035;2482.0816297969777;2187.8796666183352;2259.836184365053;2437.1348171399163;2437.244454219189;2442.755724427561;2320.7795259450327;2357.2456813819585;2393.3777217923293;2395.556821987938;2400.6159014557675;2419.250032489934;2464.667269918556;2469.703635563726;2475;2480.7767300943;2427.684401027873;2471.8764061796837;2485.142625794098;2488.2410864686262;2491.7757401833924;8675.913240867574;8729.388942774009;8741.694040708608;8759.78100547485;8773.25427338677;5325.334333208349;5428.45715428458;5435.592330575183;5437.13005919055;5483.2049352844015;3363.764536482447;3603.657652523006;3680.9815950920342;3684.4104943209227;3691.427828686558;896.3053633434075;1038.4132964874898;1044.3785947361307;1065.6696424108552;1079.3092420850662;9716.95141524295;11500.597479088192;11671.1830171888;11707.7073073173;11716.414179291087;4867.148249056472;4914.33656456381;4937.012597480519;4975.402951645753;5026.195808670595;8266.214709602578;10088.44513551747;10125.898741012496;10129.94935025335;10180.134688551556;5350.571954243651;5355.410904800468;5404.162354835007;5424.403315635277;5478.945210547923;4354.107407981356;4527.728336299832;4742.4309082909585;4848.10310092634;4919.262110683355;3866.4007078902814;3956.2680904032845;3959.5842436544326;3978.104926391539;4010.47863777707;1286.4339690536135;1304.5955753716378;1305.2560040776857;1319.2546211390534;1320.6038188543398;1146.5986904583497;1162.924409913353;1307.4508706343167;1393.3590548347875;1418.936147873348;7400.370968467633;7597.696092156362;8128.715494957766;8195.016598008158;8204.712835050745;513.1276829390052;528.5164074871526;530.5013287509729;537.7472587883689;539.4740128374804;6210.913090209286;6240.31356550779;6249.375062493805;6268.4671802897265;6287.622742635456;10194.898051019543;10507.894921050845;10607.787844243072;10614.787704246026;10626.043656070991;10152.695419137437;10297;10305.227107966932;10406.323588966692;10473.47632618366;8132.308753755997;8187.426880118334;8251.95874020626;8261.917380826235;8299.958500207582;7686.46194766361;7757.069151701832;7800.960995194988;7804.804879878048;7839.294463498084;9282.953585232031;9287.210587100171;9295.581698823704;9385.953070234606;9407.341486095907;9007.234385077341;9353.766155846159;9514.524273786421;9788.657396991071;9791.51042447889;6742.089817874524;6932.896006559805;7136.215016348094;7333.413326933725;7452.813679658052;6699.39705426514;8045.517268963881;8064.072631647201;8076.919230807852;8097.514149151069;6787.457003439614;6952.374286314256;7044.929550704633;7204.71181152748;7376.225496322809;7079.221285658677;7093.467989900882;7195.244499327705;7198.532095413991;7207;7476.626168691652;7562.357199638092;7610.467267291237;7696.653650585625;7696.8075798103255;6941.757038503628;6945.861082778417;6990.056342393915;6996.055532503047;7001.159860816734;7040.049593305043;7053.4004609608755;7122;7143.749968751069;7148.928510714826 04:57:34 INFO - PROCESS | 1963 | |4;prototype.html;266.68397948431107;328.83722557334124;330.29152467956243;333.42983498218047;340.5929913753066;5743.994800909845;6459.967700161505;6538.542302038853;6548.345165483455;6571.408573228408;5714.285714285715;5993.670348130851;6389;6493.220813502375;6504.089427480145;4558.544145585448;4675.953240467603;4681.368015317939;4820.638452116088;4823.469418363977;4771.71369717818;4773.57037866592;4804.351412559295;4807.23084306511;4831.275308703687;4758.857234282977;4766.904661906759;4769.666123371366;4773.498782627827;4775.5463230993;4552.772361381918;4621.121986822526;4760.428748550179;4772.355731976173;4779.737114458703;4051.311277082903;4056.1076563156057;4060.8984775380554;4064.471618689581;4067.410225517313;6158.753649854;6179.351168127327;6180.969095154541;6204.6587437690905;6297.590656607306;5482.205080263339;5483.890322193573;5484.369297530755;5485.341758988947;5505.504504594605;6809.182898052216;6829.317068293131;6830.248672646005;6834.521583489158;6842.589444633288;4287.442632457761;4443.466783985942;4451.5103338632725;4480.462344518679;4499.505054444008;6091.690286588405;7006.194287656934;7179.246179151219;7285.526440781386;7298.306660867209;4547.704399214107;4549.727016379028;4557.931631025537;4558.680892337571;4562.429696287964;4603.194440972817;4608.009278005245;4616.446026476844;4617.653675974316;4625.190591646448;5478.945210547923;5481.369642491085;5483.972580137074;5484.698341591171;5494.09347457673;6613;6842.281560436182;6862.862742745217;6906.792796216121;6915.308469153045;1579.068349673698;1585.3024669145539;1600.7518834580658;1601.7677436771835;1602.4872040947018;970.2965350121106;997.6258902911409;1019.8062368150028;1021.3301252452146;1047.073340094007;5331.786728530893;6402.423781859655;6503.512236582275;6547.508936829661;6609.7111063343145;5498.367687715964;7216.7113315466795;7225.602591857393;7233.168185658611;7259.963700181571;6547.607143571401;6549.639769812706;6568.244651865097;6574.704138313788;6591.472682185414;3760.7743535387963;3779.905502362463;3799.5630502492013;3799.810009499514;3802.2205447883116;6112.449879510866;7272.781801550578;7571.962140189264;7605.771826845204;7613.467057306047;7358.632068396666;7414.592197429085;7414.888776668355;7416.147143078615;7420.666070026862;6357.523185761086;7272;7531.246875312425;7551.358134558624;7553.546787192786;6963.24004621922;7176.569405835667;7189.424846012411;7198.89201661965;7202.783916482514;6976.372126508639;7081.575105493687;7092.468064895257;7104.502684812013;7116.288371163049;6671.966640166962;7492.175860655432;7557.2820582044615;7562.697492100255;7569.810754731176;4189.476315460567;4535.31970204472;4565.429321334833;4574;4582.679212455096;7118.181409138016;7132.572045677276;7133.536320139175;7134.750283740044;7139.21468638439;5604.915926261191;6666.166729158856;6831.760888368884;6931.965340173267;6966.407855332353;5583.888322233452;6862.691178896862;6903;6909.136357955255;6927.064846245692;5454.645448045864;6756.966215168893;6766.15423072116;6771.3905748482875;6773.153355830521;6910.615837536042;6912.654367281515;6913.2049814272;6917.481188910952;6929.237783843874;6486.902696459462;6502.349765023649;6620.404163625297;6639.2696803352555;6745.797626071226 04:57:34 INFO - PROCESS | 1963 | |5;yui.html;686.6978529447041;695.2838576266444;738.2838646512882;758.908930928288;776.5107981971357;15100.697986040273;15279.618009549768;15298.2350882456;15311.310991005405;15317.310721017553;13830.930845345785;14332.570022899303;14336.56990290293;14359.425622975095;14371.35328910199;738.0737174845561;738.5790099643206;897.4929165021741;904.7692838326251;919.103873723118;939.0515579264924;940.4592359393342;940.5485367023832;941.665708673418;943.7168849345203;970.912617864392;971.1453920549906;974.7952929884733;975.2636759246759;977.3549457358109;771.3250905457725;957.5403806173007;971.4608392342247;972.4554249620236;974.3179774158046;727.7343769524139;727.9745208917662;728.5774250934498;729.657061181244;730.4886579394445;12856.485740570366;14340.56978290653;15109.39562417502;15153.893451842347;15171.317290721943;12370.44333005017;12439.440225189888;12498.312592807391;12646.051546133986;12748.107632465732;9492.193163581034;9585.233181345475;10049.497525123714;10116.848247276297;10384.428856412895;3495.056334789618;3519.7360197985254;3542.415501442259;3586.946195807065;3595.7123430125525;78047;79061.20938790595;79165.81251281235;79529.80705289425;79989.40021199602;9337.766555836022;9387.249020078378;9593.760155996157;9670.323077384657;10293.691189264335;21939.67090493644;22006.889965550068;22391.664125038136;22405.88797056004;22407.55184896293;7369.078865141857;7517.736879209201;7534.886976695354;7626.504277221963;7681.7695469136015;3824.0822202671156;3846.249981253629;3953.5058117735284;3958.6635136013188;3970.4441378207075;2920.8977685780897;3629.8366573503727;3632.473291372789;3632.8546858125906;3639.3085313790293;632.8607706304606;646.0116022485605;653.6013032050446;659.7558903205845;660.8975608780647;524.2686452398882;595.8391234366696;598.3418239936123;599.6492052149541;605.4218221598363;7894.644740986554;7986.7603971880935;8102.51384916895;8272.503649781032;8314.750557483285;573.263356586784;589.548995018811;590.2533295381346;594.8334466349429;600;3711.2391959648207;3727.5713292971113;3772.8113594320175;3826.4260360945523;3900.941485877714;80500.38999219982;81011;81041;81185.59407202926;84826.15173848307;79287;79627.60186199032;80454;80823.38353232903;80994.59502702567;64729;65085.67457162684;65872.34127658758;66337.66831165813;66558.99999999903;7556.1310449299035;7590.013298271189;7610.315071643578;7622.199669034671;7800.219978002381;46950.76524617355;47892.76053619709;48009.21930266574;48088.79778005438;48223.75888120537;61200;67039.65920681656;67178;67656;68865;8198.795030124294;10023.498825058572;10097.44464054484;10262.948685256526;10346.586136554453;10739.838902416313;10743.677689669323;10785.676429707122;10851.038528619045;11109.388983605979;10214.131798796889;10248.692539223835;10549.841752373874;10558.04977552024;10579.735506612396;10375.533101010624;10429.269951103654;10508.264421490423;10622.946885265525;10642.787144257227;9825.4104753715;9872.703818885446;9876;10101;10316.17470602365;8355.781702085302;8681.6093275804;8713.651453941771;8777.42946708462;8958.283337332867;8351.373646976623;8562.74311770648;8619;8840.282976308157;8841 04:57:34 INFO - PROCESS | 1963 | __end_tp_report 04:57:34 INFO - PROCESS | 1963 | __start_cc_report 04:57:34 INFO - PROCESS | 1963 | _x_x_mozilla_cycle_collect,1057 04:57:34 INFO - PROCESS | 1963 | __end_cc_report 04:57:34 INFO - PROCESS | 1963 | __startTimestamp1458043054806__endTimestamp 04:57:34 INFO - PROCESS | 1963 | 04:57:34 INFO - PROCESS | 1963 | ------- Summary: start ------- 04:57:34 INFO - PROCESS | 1963 | Number of tests: 6 04:57:34 INFO - PROCESS | 1963 | 04:57:34 INFO - PROCESS | 1963 | [#0] dojo.html Cycles:165 Average:5619.47 Median:5765.80 stddev:666.72 (11.6%) stddev-sans-first:640.03 04:57:34 INFO - PROCESS | 1963 | Values: 3151.3 3414.1 3443.7 3469.7 3483.5 5515.0 5515.3 5538.8 5549.6 5578.4 4426.8 5519.5 5567.3 5570.4 5604.7 5071.1 5074.3 5101.8 5172.1 5180.5 5122.3 5161.1 5181.5 5195.9 5207.9 5127.1 5150.3 5188.8 5189.5 5194.7 5114.8 5155.6 5156.3 5161.2 5201.0 5000.5 5058.0 5079.4 5081.6 5099.9 4153.0 5400.8 5461.1 5486.0 5571.5 6135.4 6141.8 6144.5 6149.1 6165.0 6114.3 6118.4 6198.4 6246.9 6264.3 5662.0 5696.3 5711.7 5716.5 5736.3 6302.9 6336.8 6338.6 6341.3 6350.1 5914.5 6016.1 6074.0 6080.0 6113.5 6159.5 6182.8 6212.9 6219.2 6233.8 6149.2 6161.3 6165.3 6169.1 6179.0 6025.8 6093.1 6116.2 6195.6 6226.8 4787.3 4804.2 4809.5 4817.9 4835.9 4294.9 4304.8 4306.5 4320.5 4374.2 5550.7 5638.3 5724.6 5742.5 5742.6 6157.3 6164.9 6180.5 6188.1 6193.3 4813.4 5659.9 5732.4 5735.5 5741.0 5297.5 5312.9 5319.1 5341.0 5353.7 5232.5 6293.1 6295.8 6300.7 6322.9 6108.6 6150.3 6238.5 6242.2 6267.3 6282.5 6284.4 6284.7 6292.1 6298.5 6082.3 6096.0 6110.0 6113.7 6116.0 4748.7 6152.0 6166.6 6186.0 6244.7 4841.4 5995.5 6031.2 6039.0 6041.5 4790.3 5944.2 5950.5 5978.3 5978.9 5738.9 5803.4 5845.5 5884.0 5941.3 5025.0 5906.0 5983.7 5993.0 6039.0 5690.0 5765.8 5779.4 5832.1 5832.7 04:57:34 INFO - PROCESS | 1963 | 04:57:34 INFO - PROCESS | 1963 | [#1] ext.html Cycles:180 Average:54711.08 Median:33590.74 stddev:103983.33 (309.6%) stddev-sans-first:104195.24 04:57:34 INFO - PROCESS | 1963 | Values: 456.7 562.8 583.6 622.7 631.7 23327.1 37211.3 37310.3 37377.6 37447.3 33206.3 41472.0 41477.0 41500.4 41673.0 9382.5 9627.1 9628.8 9636.0 9647.6 9459.8 9551.2 9556.3 9587.8 9632.3 9594.7 9779.0 9792.3 9793.1 9794.9 9668.7 9765.5 9775.1 9776.5 9786.8 8367.5 9559.2 9596.8 9667.7 9670.4 39347.8 39737.4 39924.8 39957.0 40039.6 3131.8 3172.1 3172.2 3207.4 3387.1 29491.3 29928.4 31244.4 31285.5 31318.1 2681.7 2705.3 2830.9 2848.1 2852.4 392122.0 394712.0 395093.0 395307.0 396270.0 68469.0 68537.7 69646.7 69882.3 69924.7 74458.0 75061.6 75264.2 75281.6 75369.9 17420.5 17530.6 17533.3 17581.3 18001.6 13432.8 13455.9 13468.1 13491.8 13527.6 18254.5 22155.7 22743.9 22771.8 22825.7 8020.4 8784.6 9580.2 10257.2 10267.2 918.2 918.3 992.3 1034.6 1058.3 28606.7 28798.3 29086.6 29530.4 29592.3 1003.9 1024.9 1076.7 1179.1 1267.6 12792.8 14996.5 15634.9 15735.6 15773.4 449866.0 454072.0 454315.0 455632.7 455698.0 56194.0 56598.0 56603.2 56634.0 56798.0 1288.9 1422.5 1452.4 1455.7 1584.3 27962.9 28059.9 28606.6 28688.7 28798.3 45229.3 45777.0 45821.9 45845.8 45940.3 263435.0 329845.0 330520.0 331232.0 331998.0 22293.0 27958.7 27961.6 31367.2 31573.5 33771.5 38281.8 39321.8 39359.4 39507.0 32789.8 33345.0 33384.0 34047.8 34305.8 33059.3 33346.0 33366.5 33401.0 33828.2 32716.7 33406.8 33433.5 33454.3 33727.2 29642.0 30444.5 30452.4 30491.0 30624.7 19580.2 20479.4 23511.3 23716.2 23925.0 04:57:34 INFO - PROCESS | 1963 | 04:57:34 INFO - PROCESS | 1963 | [#2] jquery.html Cycles:180 Average:33325.54 Median:359.50 stddev:100692.07 (28009.2%) stddev-sans-first:100944.11 04:57:34 INFO - PROCESS | 1963 | Values: 359.3 359.6 361.1 363.8 369.8 15524.8 19633.8 20926.5 20944.4 20955.0 20020.1 20389.9 20931.4 21211.2 21244.9 5807.1 5937.3 5973.4 6025.0 6028.4 4220.3 4490.0 5989.0 6500.4 6542.6 5498.5 5567.9 6345.0 6398.5 6443.2 6278.2 6319.2 6417.1 6447.5 6474.5 5589.2 5606.4 5613.4 5627.4 5627.5 24433.8 25544.4 25924.6 25983.7 25991.7 2060.6 2162.0 2181.7 2240.4 2516.5 9470.0 9696.7 9895.3 9974.5 14220.9 1752.4 1809.0 1818.7 1861.6 1923.2 69442.7 70353.6 82947.0 92725.0 102113.5 10115.5 10381.5 11084.6 11248.2 11324.2 13507.0 13547.1 13563.8 13564.4 13613.9 8442.5 8675.6 8675.6 8744.7 8790.8 8811.8 8833.9 8852.6 8937.0 8963.0 4442.6 4504.6 4511.5 4544.4 4556.9 1709.3 1772.3 1829.4 1889.1 1896.1 698.5 767.8 901.8 936.7 1019.1 15085.8 18110.5 20096.8 20313.3 20706.0 959.5 969.7 973.3 978.3 1018.8 10597.3 11077.7 11138.0 11147.7 11184.8 602523.0 602862.0 607561.0 617743.0 619827.0 112364.0 112603.0 112896.0 114372.0 115557.7 1020.3 1029.6 1050.2 1051.0 1053.1 17772.4 17815.7 18035.0 18425.5 18472.4 36097.6 47790.8 47962.0 48082.3 48315.5 68400.0 68527.3 68542.3 69712.6 70695.6 6569.4 6963.4 7235.4 7663.1 7990.1 10909.3 11979.0 12087.2 12241.6 12282.9 8638.9 10380.7 10532.3 10643.8 10786.4 8206.7 9963.9 10444.0 10483.3 10541.0 10615.3 10858.8 10964.7 10991.7 11075.6 6181.3 7548.2 7616.1 7709.9 7938.2 9241.9 10548.8 10555.5 10805.8 10821.7 04:57:34 INFO - PROCESS | 1963 | 04:57:34 INFO - PROCESS | 1963 | [#3] mootools.html Cycles:180 Average:5923.34 Median:5414.28 stddev:3101.52 (57.3%) stddev-sans-first:3091.86 04:57:34 INFO - PROCESS | 1963 | Values: 1433.3 1570.4 1605.3 1883.5 2018.4 7905.9 8413.5 8535.4 8554.8 8555.1 8277.3 8580.4 8581.7 8584.3 8591.6 2181.8 2406.4 2453.8 2475.7 2482.1 2187.9 2259.8 2437.1 2437.2 2442.8 2320.8 2357.2 2393.4 2395.6 2400.6 2419.3 2464.7 2469.7 2475.0 2480.8 2427.7 2471.9 2485.1 2488.2 2491.8 8675.9 8729.4 8741.7 8759.8 8773.3 5325.3 5428.5 5435.6 5437.1 5483.2 3363.8 3603.7 3681.0 3684.4 3691.4 896.3 1038.4 1044.4 1065.7 1079.3 9717.0 11500.6 11671.2 11707.7 11716.4 4867.1 4914.3 4937.0 4975.4 5026.2 8266.2 10088.4 10125.9 10129.9 10180.1 5350.6 5355.4 5404.2 5424.4 5478.9 4354.1 4527.7 4742.4 4848.1 4919.3 3866.4 3956.3 3959.6 3978.1 4010.5 1286.4 1304.6 1305.3 1319.3 1320.6 1146.6 1162.9 1307.5 1393.4 1418.9 7400.4 7597.7 8128.7 8195.0 8204.7 513.1 528.5 530.5 537.7 539.5 6210.9 6240.3 6249.4 6268.5 6287.6 10194.9 10507.9 10607.8 10614.8 10626.0 10152.7 10297.0 10305.2 10406.3 10473.5 8132.3 8187.4 8252.0 8261.9 8300.0 7686.5 7757.1 7801.0 7804.8 7839.3 9283.0 9287.2 9295.6 9386.0 9407.3 9007.2 9353.8 9514.5 9788.7 9791.5 6742.1 6932.9 7136.2 7333.4 7452.8 6699.4 8045.5 8064.1 8076.9 8097.5 6787.5 6952.4 7044.9 7204.7 7376.2 7079.2 7093.5 7195.2 7198.5 7207.0 7476.6 7562.4 7610.5 7696.7 7696.8 6941.8 6945.9 6990.1 6996.1 7001.2 7040.0 7053.4 7122.0 7143.7 7148.9 04:57:34 INFO - PROCESS | 1963 | 04:57:34 INFO - PROCESS | 1963 | [#4] prototype.html Cycles:180 Average:5606.79 Median:6431.20 stddev:1788.94 (27.8%) stddev-sans-first:1748.48 04:57:34 INFO - PROCESS | 1963 | Values: 266.7 328.8 330.3 333.4 340.6 5744.0 6460.0 6538.5 6548.3 6571.4 5714.3 5993.7 6389.0 6493.2 6504.1 4558.5 4676.0 4681.4 4820.6 4823.5 4771.7 4773.6 4804.4 4807.2 4831.3 4758.9 4766.9 4769.7 4773.5 4775.5 4552.8 4621.1 4760.4 4772.4 4779.7 4051.3 4056.1 4060.9 4064.5 4067.4 6158.8 6179.4 6181.0 6204.7 6297.6 5482.2 5483.9 5484.4 5485.3 5505.5 6809.2 6829.3 6830.2 6834.5 6842.6 4287.4 4443.5 4451.5 4480.5 4499.5 6091.7 7006.2 7179.2 7285.5 7298.3 4547.7 4549.7 4557.9 4558.7 4562.4 4603.2 4608.0 4616.4 4617.7 4625.2 5478.9 5481.4 5484.0 5484.7 5494.1 6613.0 6842.3 6862.9 6906.8 6915.3 1579.1 1585.3 1600.8 1601.8 1602.5 970.3 997.6 1019.8 1021.3 1047.1 5331.8 6402.4 6503.5 6547.5 6609.7 5498.4 7216.7 7225.6 7233.2 7260.0 6547.6 6549.6 6568.2 6574.7 6591.5 3760.8 3779.9 3799.6 3799.8 3802.2 6112.4 7272.8 7572.0 7605.8 7613.5 7358.6 7414.6 7414.9 7416.1 7420.7 6357.5 7272.0 7531.2 7551.4 7553.5 6963.2 7176.6 7189.4 7198.9 7202.8 6976.4 7081.6 7092.5 7104.5 7116.3 6672.0 7492.2 7557.3 7562.7 7569.8 4189.5 4535.3 4565.4 4574.0 4582.7 7118.2 7132.6 7133.5 7134.8 7139.2 5604.9 6666.2 6831.8 6932.0 6966.4 5583.9 6862.7 6903.0 6909.1 6927.1 5454.6 6757.0 6766.2 6771.4 6773.2 6910.6 6912.7 6913.2 6917.5 6929.2 6486.9 6502.3 6620.4 6639.3 6745.8 04:57:34 INFO - PROCESS | 1963 | 04:57:34 INFO - PROCESS | 1963 | [#5] yui.html Cycles:180 Average:17593.10 Median:33262.97 stddev:24608.69 (74.0%) stddev-sans-first:24644.98 04:57:34 INFO - PROCESS | 1963 | Values: 686.7 695.3 738.3 758.9 776.5 15100.7 15279.6 15298.2 15311.3 15317.3 13830.9 14332.6 14336.6 14359.4 14371.4 738.1 738.6 897.5 904.8 919.1 939.1 940.5 940.5 941.7 943.7 970.9 971.1 974.8 975.3 977.4 771.3 957.5 971.5 972.5 974.3 727.7 728.0 728.6 729.7 730.5 12856.5 14340.6 15109.4 15153.9 15171.3 12370.4 12439.4 12498.3 12646.1 12748.1 9492.2 9585.2 10049.5 10116.8 10384.4 3495.1 3519.7 3542.4 3586.9 3595.7 78047.0 79061.2 79165.8 79529.8 79989.4 9337.8 9387.2 9593.8 9670.3 10293.7 21939.7 22006.9 22391.7 22405.9 22407.6 7369.1 7517.7 7534.9 7626.5 7681.8 3824.1 3846.2 3953.5 3958.7 3970.4 2920.9 3629.8 3632.5 3632.9 3639.3 632.9 646.0 653.6 659.8 660.9 524.3 595.8 598.3 599.6 605.4 7894.6 7986.8 8102.5 8272.5 8314.8 573.3 589.5 590.3 594.8 600.0 3711.2 3727.6 3772.8 3826.4 3900.9 80500.4 81011.0 81041.0 81185.6 84826.2 79287.0 79627.6 80454.0 80823.4 80994.6 64729.0 65085.7 65872.3 66337.7 66559.0 7556.1 7590.0 7610.3 7622.2 7800.2 46950.8 47892.8 48009.2 48088.8 48223.8 61200.0 67039.7 67178.0 67656.0 68865.0 8198.8 10023.5 10097.4 10262.9 10346.6 10739.8 10743.7 10785.7 10851.0 11109.4 10214.1 10248.7 10549.8 10558.0 10579.7 10375.5 10429.3 10508.3 10622.9 10642.8 9825.4 9872.7 9876.0 10101.0 10316.2 8355.8 8681.6 8713.7 8777.4 8958.3 8351.4 8562.7 8619.0 8840.3 8841.0 04:57:34 INFO - PROCESS | 1963 | -------- Summary: end -------- 04:57:34 INFO - PROCESS | 1963 | 04:57:35 INFO - TEST-INFO | 1963: exit 0 04:57:35 INFO - TEST-OK | dromaeo_css | took 1113588ms 04:57:35 INFO - TEST-START | kraken 04:57:35 INFO - operating with platform_type : mac_ 04:57:35 INFO - Initialising browser for kraken test... 04:57:35 INFO - TEST-INFO | started process 1966 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmp4BAlLp/profile http://localhost:57300/getInfo.html) 04:57:37 INFO - PROCESS | 1966 | __metrics Screen width/height:1600/1200 04:57:37 INFO - PROCESS | 1966 | colorDepth:24 04:57:37 INFO - PROCESS | 1966 | Browser inner width/height: 1024/689 04:57:37 INFO - PROCESS | 1966 | __metrics 04:57:37 INFO - PROCESS | 1966 | 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" 04:57:37 ERROR - PROCESS | 1966 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 04:57:38 INFO - TEST-INFO | 1966: exit 0 04:57:38 INFO - Browser initialized. 04:57:38 INFO - Running cycle 1/1 for kraken test... 04:57:38 INFO - TEST-INFO | started process 1968 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/T/tmp4BAlLp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:57:50 INFO - PROCESS | 1968 | RSS: Main: 243294208 04:57:50 INFO - PROCESS | 1968 | 04:57:52 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:57300/tests/kraken/driver.html?testName=audio-beat-detection) 04:57:53 INFO - PROCESS | 1968 | RSS: Main: 291221504 04:57:53 INFO - PROCESS | 1968 | 04:57:56 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:57300/tests/kraken/driver.html?testName=audio-dft) 04:57:56 INFO - PROCESS | 1968 | RSS: Main: 299368448 04:57:56 INFO - PROCESS | 1968 | 04:58:00 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:57300/tests/kraken/driver.html?testName=audio-fft) 04:58:00 INFO - PROCESS | 1968 | RSS: Main: 286867456 04:58:00 INFO - PROCESS | 1968 | 04:58:02 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:57300/tests/kraken/driver.html?testName=audio-oscillator) 04:58:03 INFO - PROCESS | 1968 | RSS: Main: 289890304 04:58:03 INFO - PROCESS | 1968 | 04:58:05 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:57300/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:58:05 INFO - PROCESS | 1968 | RSS: Main: 290340864 04:58:05 INFO - PROCESS | 1968 | 04:58:08 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:57300/tests/kraken/driver.html?testName=imaging-darkroom) 04:58:09 INFO - PROCESS | 1968 | RSS: Main: 291516416 04:58:09 INFO - PROCESS | 1968 | 04:58:12 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:57300/tests/kraken/driver.html?testName=imaging-desaturate) 04:58:12 INFO - PROCESS | 1968 | RSS: Main: 291971072 04:58:12 INFO - PROCESS | 1968 | 04:58:15 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:57300/tests/kraken/driver.html?testName=json-parse-financial) 04:58:16 INFO - PROCESS | 1968 | RSS: Main: 292716544 04:58:16 INFO - PROCESS | 1968 | 04:58:17 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:57300/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:58:18 INFO - PROCESS | 1968 | RSS: Main: 323813376 04:58:18 INFO - PROCESS | 1968 | 04:58:20 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:57300/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:58:20 INFO - PROCESS | 1968 | RSS: Main: 323792896 04:58:20 INFO - PROCESS | 1968 | 04:58:22 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:57300/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:58:23 INFO - PROCESS | 1968 | RSS: Main: 332132352 04:58:23 INFO - PROCESS | 1968 | 04:58:26 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:57300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:58:26 INFO - PROCESS | 1968 | RSS: Main: 332750848 04:58:26 INFO - PROCESS | 1968 | 04:58:29 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:57300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:58:29 INFO - PROCESS | 1968 | RSS: Main: 333119488 04:58:29 INFO - PROCESS | 1968 | 04:58:31 INFO - PROCESS | 1968 | Cycle 1(1): loaded http://localhost:57300/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:57300/tests/kraken/driver.html?testName=ai-astar) 04:58:31 INFO - PROCESS | 1968 | RSS: Main: 392462336 04:58:31 INFO - PROCESS | 1968 | 04:58:31 INFO - PROCESS | 1968 | __start_tp_report 04:58:31 INFO - PROCESS | 1968 | _x_x_mozilla_page_load 04:58:31 INFO - PROCESS | 1968 | _x_x_mozilla_page_load_details 04:58:31 INFO - PROCESS | 1968 | |i|pagename|runs| 04:58:31 INFO - PROCESS | 1968 | |0;ai-astar;112;110;109;111;111;110;116;111;111;109 04:58:31 INFO - PROCESS | 1968 | |1;audio-beat-detection;157;120;152;193;122;142;137;119;163;119 04:58:31 INFO - PROCESS | 1968 | |2;audio-dft;185;184;189;183;186;197;186;188;184;187 04:58:31 INFO - PROCESS | 1968 | |3;audio-fft;75;81;84;80;57;57;60;81;88;80 04:58:31 INFO - PROCESS | 1968 | |4;audio-oscillator;88;98;125;79;77;88;114;77;80;115 04:58:31 INFO - PROCESS | 1968 | |5;imaging-gaussian-blur;88;86;90;85;88;90;88;86;88;84 04:58:31 INFO - PROCESS | 1968 | |6;imaging-darkroom;92;94;94;93;93;93;94;94;93;96 04:58:31 INFO - PROCESS | 1968 | |7;imaging-desaturate;86;87;86;86;93;135;85;87;87;92 04:58:31 INFO - PROCESS | 1968 | |8;json-parse-financial;56;54;54;53;55;54;54;66;56;53 04:58:31 INFO - PROCESS | 1968 | |9;json-stringify-tinderbox;67;62;74;73;72;70;71;69;91;62 04:58:31 INFO - PROCESS | 1968 | |10;stanford-crypto-aes;83;80;83;83;81;80;83;82;83;84 04:58:31 INFO - PROCESS | 1968 | |11;stanford-crypto-ccm;119;137;137;130;127;125;114;120;124;127 04:58:31 INFO - PROCESS | 1968 | |12;stanford-crypto-pbkdf2;140;126;141;142;136;125;140;138;142;123 04:58:31 INFO - PROCESS | 1968 | |13;stanford-crypto-sha256-iterative;68;66;66;68;68;69;67;69;68;67 04:58:31 INFO - PROCESS | 1968 | __end_tp_report 04:58:31 INFO - PROCESS | 1968 | __start_cc_report 04:58:31 INFO - PROCESS | 1968 | _x_x_mozilla_cycle_collect,1323 04:58:31 INFO - PROCESS | 1968 | __end_cc_report 04:58:31 INFO - PROCESS | 1968 | __startTimestamp1458043111734__endTimestamp 04:58:31 INFO - PROCESS | 1968 | 04:58:31 INFO - PROCESS | 1968 | ------- Summary: start ------- 04:58:31 INFO - PROCESS | 1968 | Number of tests: 14 04:58:31 INFO - PROCESS | 1968 | 04:58:31 INFO - PROCESS | 1968 | [#0] ai-astar Cycles:10 Average:111.00 Median:111.00 stddev:2.00 (1.8%) stddev-sans-first:2.09 04:58:31 INFO - PROCESS | 1968 | Values: 112.0 110.0 109.0 111.0 111.0 110.0 116.0 111.0 111.0 109.0 04:58:31 INFO - PROCESS | 1968 | 04:58:31 INFO - PROCESS | 1968 | [#1] audio-beat-detection Cycles:10 Average:142.40 Median:147.00 stddev:24.34 (16.6%) stddev-sans-first:25.24 04:58:31 INFO - PROCESS | 1968 | Values: 157.0 120.0 152.0 193.0 122.0 142.0 137.0 119.0 163.0 119.0 04:58:31 INFO - PROCESS | 1968 | 04:58:31 INFO - PROCESS | 1968 | [#2] audio-dft Cycles:10 Average:186.90 Median:186.50 stddev:4.01 (2.2%) stddev-sans-first:4.20 04:58:31 INFO - PROCESS | 1968 | Values: 185.0 184.0 189.0 183.0 186.0 197.0 186.0 188.0 184.0 187.0 04:58:31 INFO - PROCESS | 1968 | 04:58:31 INFO - PROCESS | 1968 | [#3] audio-fft Cycles:10 Average:74.30 Median:80.50 stddev:11.74 (14.6%) stddev-sans-first:12.45 04:58:31 INFO - PROCESS | 1968 | Values: 75.0 81.0 84.0 80.0 57.0 57.0 60.0 81.0 88.0 80.0 04:58:31 INFO - PROCESS | 1968 | 04:58:31 INFO - PROCESS | 1968 | [#4] audio-oscillator Cycles:10 Average:94.10 Median:79.50 stddev:17.92 (22.5%) stddev-sans-first:18.87 04:58:31 INFO - PROCESS | 1968 | Values: 88.0 98.0 125.0 79.0 77.0 88.0 114.0 77.0 80.0 115.0 04:58:31 INFO - PROCESS | 1968 | 04:58:31 INFO - PROCESS | 1968 | [#5] imaging-gaussian-blur Cycles:10 Average:87.30 Median:88.00 stddev:2.00 (2.3%) stddev-sans-first:2.11 04:58:31 INFO - PROCESS | 1968 | Values: 88.0 86.0 90.0 85.0 88.0 90.0 88.0 86.0 88.0 84.0 04:58:31 INFO - PROCESS | 1968 | 04:58:31 INFO - PROCESS | 1968 | [#6] imaging-darkroom Cycles:10 Average:93.60 Median:94.00 stddev:1.07 (1.1%) stddev-sans-first:0.97 04:58:31 INFO - PROCESS | 1968 | Values: 92.0 94.0 94.0 93.0 93.0 93.0 94.0 94.0 93.0 96.0 04:58:31 INFO - PROCESS | 1968 | 04:58:31 INFO - PROCESS | 1968 | [#7] imaging-desaturate Cycles:10 Average:92.40 Median:87.00 stddev:15.20 (17.5%) stddev-sans-first:15.95 04:58:31 INFO - PROCESS | 1968 | Values: 86.0 87.0 86.0 86.0 93.0 135.0 85.0 87.0 87.0 92.0 04:58:31 INFO - PROCESS | 1968 | 04:58:31 INFO - PROCESS | 1968 | [#8] json-parse-financial Cycles:10 Average:55.50 Median:54.50 stddev:3.84 (7.0%) stddev-sans-first:4.07 04:58:31 INFO - PROCESS | 1968 | Values: 56.0 54.0 54.0 53.0 55.0 54.0 54.0 66.0 56.0 53.0 04:58:31 INFO - PROCESS | 1968 | 04:58:31 INFO - PROCESS | 1968 | [#9] json-stringify-tinderbox Cycles:10 Average:71.10 Median:71.50 stddev:8.14 (11.4%) stddev-sans-first:8.50 04:58:31 INFO - PROCESS | 1968 | Values: 67.0 62.0 74.0 73.0 72.0 70.0 71.0 69.0 91.0 62.0 04:58:31 INFO - PROCESS | 1968 | 04:58:31 INFO - PROCESS | 1968 | [#10] stanford-crypto-aes Cycles:10 Average:82.20 Median:83.00 stddev:1.40 (1.7%) stddev-sans-first:1.45 04:58:31 INFO - PROCESS | 1968 | Values: 83.0 80.0 83.0 83.0 81.0 80.0 83.0 82.0 83.0 84.0 04:58:31 INFO - PROCESS | 1968 | 04:58:31 INFO - PROCESS | 1968 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:127.00 stddev:7.41 (5.8%) stddev-sans-first:7.41 04:58:31 INFO - PROCESS | 1968 | Values: 119.0 137.0 137.0 130.0 127.0 125.0 114.0 120.0 124.0 127.0 04:58:31 INFO - PROCESS | 1968 | 04:58:31 INFO - PROCESS | 1968 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:135.30 Median:140.00 stddev:7.59 (5.4%) stddev-sans-first:7.85 04:58:31 INFO - PROCESS | 1968 | Values: 140.0 126.0 141.0 142.0 136.0 125.0 140.0 138.0 142.0 123.0 04:58:31 INFO - PROCESS | 1968 | 04:58:31 INFO - PROCESS | 1968 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.60 Median:68.00 stddev:1.07 (1.6%) stddev-sans-first:1.13 04:58:31 INFO - PROCESS | 1968 | Values: 68.0 66.0 66.0 68.0 68.0 69.0 67.0 69.0 68.0 67.0 04:58:31 INFO - PROCESS | 1968 | -------- Summary: end -------- 04:58:31 INFO - PROCESS | 1968 | 04:58:32 INFO - TEST-INFO | 1968: exit 0 04:58:32 INFO - TEST-OK | kraken | took 57156ms 04:58:32 INFO - SUITE-END | took 1170s 04:58:32 INFO - Completed test suite (00:19:31) 04:58:32 INFO - javascript benchmark 04:58:32 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3151.3382189740155, 3414.095264754839, 3443.69006789389, 3469.7224222062237, 3483.460063690129, 5514.972425137878, 5515.33815942087, 5538.7784488620455, 5549.556035517164, 5578.386377498472, 4426.756528390937, 5519.503244707976, 5567.3040869891265, 5570.359408668004, 5604.719764011804, 5071.061853557086, 5074.314967479399, 5101.846944591668, 5172.09488339541, 5180.533751962323, 5122.308488354061, 5161.122609156434, 5181.533661970422, 5195.922061169085, 5207.895842083156, 5127.077126117298, 5150.2532132840715, 5188.844334669947, 5189.532942035216, 5194.688318700871, 5114.820981265657, 5155.639105262614, 5156.278121063016, 5161.200013997799, 5201.0, 5000.524950129732, 5058.038972595195, 5079.4412614612365, 5081.618878584121, 5099.949000509984, 4152.979235103805, 5400.756965936543, 5461.126219804852, 5486.0, 5571.526420254283, 6135.417135372132, 6141.78503752371, 6144.5084393248435, 6149.13912052313, 6165.0, 6114.327423983358, 6118.418750218722, 6198.380161983766, 6246.875562398766, 6264.279607845065, 5662.009148399014, 5696.316442026942, 5711.7144142792695, 5716.514096301861, 5736.282964629421, 6302.936970630235, 6336.841578960563, 6338.556301058974, 6341.3341599132345, 6350.142730731384, 5914.497267732291, 6016.127661489059, 6074.028155495188, 6080.027195648675, 6113.480354169857, 6159.538034647419, 6182.845428864314, 6212.9068063979075, 6219.160413344141, 6233.75064997395, 6149.2313460817395, 6161.322254551996, 6165.32181460039, 6169.105479705508, 6179.0, 6025.789097381658, 6093.111789665744, 6116.235470566179, 6195.597286176474, 6226.813195604139, 4787.281907713871, 4804.2073057945745, 4809.519048095232, 4817.855464336076, 4835.879103022453, 4294.935575966363, 4304.8161755517485, 4306.504751953503, 4320.503142138631, 4374.21264172452, 5550.69471179089, 5638.295213098363, 5724.627899186539, 5742.483176514133, 5742.59801813869, 6157.291911430153, 6164.938350616526, 6180.47465965398, 6188.0717892315615, 6193.349698281616, 4813.422389313305, 5659.886802263932, 5732.426757324234, 5735.483806457439, 5740.971295143498, 5297.470252974672, 5312.946870531246, 5319.069162896478, 5341.0, 5353.7055461949185, 5232.502912223333, 6293.118963345135, 6295.842603934847, 6300.7479700811455, 6322.936770632419, 6108.633481991094, 6150.261968563801, 6238.532110091671, 6242.157308763259, 6267.279262884645, 6282.528810339151, 6284.4344009039405, 6284.717187726655, 6292.087647291209, 6298.496120310272, 6082.300535438481, 6095.969520152371, 6109.961306577804, 6113.663748493697, 6115.990861507801, 4748.715077095385, 6152.0, 6166.599171053867, 6186.041163619646, 6244.687765611792, 4841.394825646794, 5995.46040856325, 6031.185789918481, 6039.0, 6041.486473649789, 4790.257510085942, 5944.227250457413, 5950.494207992196, 5978.282606087298, 5978.910316345346, 5738.942610573841, 5803.419658034163, 5845.532357411312, 5884.0, 5941.346451890375, 5024.969881174424, 5906.0, 5983.730732117152, 5992.970035149797, 6038.969805151122, 5690.032694442038, 5765.798197063083, 5779.422057794187, 5832.12518122285, 5832.679202643895], "unit": "score", "name": "dojo.html", "value": 5579.427394921751}, {"lowerIsBetter": false, "replicates": [456.6940150099433, 562.7608266486742, 583.5564970622329, 622.6668732228258, 631.6525910749087, 23327.066917323307, 37211.25577488452, 37310.25379492409, 37377.62622373775, 37447.251054978886, 33206.33587328252, 41472.0, 41476.963075923115, 41500.37749433761, 41672.95817604554, 9382.483963381994, 9627.13355797978, 9628.807423851518, 9635.951820240889, 9647.614095436174, 9459.763505912339, 9551.235901127893, 9556.283278754086, 9587.760305992371, 9632.325737198398, 9594.712158635251, 9779.022097790199, 9792.314537982344, 9793.069658382443, 9794.902050979506, 9668.661596844111, 9765.511724413751, 9775.071368220008, 9776.51117444132, 9786.804263914717, 8367.539785311805, 9559.187469065138, 9596.808063838755, 9667.70996870095, 9670.419774813463, 39347.8032609838, 39737.40393894094, 39924.800375998224, 39957.0, 40039.59960400388, 3131.7964332318325, 3172.12766489215, 3172.159377764894, 3207.4226639204935, 3387.1024178592693, 29491.262718431997, 29928.401431971455, 31244.375112497622, 31285.530717039263, 31318.06045818629, 2681.6916054653575, 2705.3236690827293, 2830.8584570771377, 2848.1455563331124, 2852.4009957908866, 392122.0, 394712.0, 395093.0, 395307.0, 396270.0, 68469.0, 68537.65731171312, 69646.65176674085, 69882.30117698859, 69924.65037674778, 74458.0, 75061.62469187619, 75264.24735752572, 75281.6235918817, 75369.86945195826, 17420.47738567845, 17530.561735956704, 17533.298668053136, 17581.296748130186, 18001.639967200583, 13432.798508022388, 13455.865441345657, 13468.057235993583, 13491.797623035662, 13527.594172174851, 18254.45236642903, 22155.667664985038, 22743.886280568822, 22771.772282277296, 22825.657615135788, 8020.398470114648, 8784.560771961376, 9580.233581313478, 10257.230707696952, 10267.229957753198, 918.2470374293149, 918.2562124679031, 992.3252188511881, 1034.5809946971488, 1058.25921854702, 28606.71393286082, 28798.280042999093, 29086.563701544495, 29530.409391812474, 29592.260193494905, 1003.9397636141855, 1024.8770147582188, 1076.741582020325, 1179.0626451970704, 1267.6387229639508, 12792.84864362212, 14996.475123370848, 15634.905556611155, 15735.606609834846, 15773.369065237492, 449866.0, 454071.9706438208, 454315.0, 455632.66204027866, 455698.0, 56194.0, 56598.0, 56603.15095273574, 56634.0, 56798.0, 1288.890444312244, 1422.502124256502, 1452.4045141491938, 1455.6943041961306, 1584.2949887300272, 27962.86018569894, 28059.859700701367, 28606.570901436913, 28688.709008095102, 28798.256226690395, 45229.321560175966, 45777.0, 45821.85445363892, 45845.77077114727, 45940.310895337265, 263435.0, 329845.0, 330520.0, 331232.0, 331998.0, 22293.0, 27958.72041279561, 27961.580576290966, 31367.21581960469, 31573.52639710452, 33771.493427599096, 38281.80859095687, 39321.80339098286, 39359.40960885532, 39507.0, 32789.83605081959, 33344.99965001054, 33384.0, 34047.82976085104, 34305.82847085749, 33059.33881322408, 33345.99962001144, 33366.499502506995, 33401.0, 33828.15429614279, 32716.67283327136, 33406.83296583501, 33433.49849752304, 33454.33091338111, 33727.15682107967, 29642.0, 30444.543331849596, 30452.41154501892, 30491.0, 30624.693753063075, 19580.216791328756, 20479.38561843147, 23511.29466116019, 23716.169934052225, 23925.0], "unit": "score", "name": "ext.html", "value": 19128.592716091665}, {"lowerIsBetter": false, "replicates": [359.3441968407655, 359.6493418916556, 361.126074898745, 363.8471841826433, 369.76704676054084, 15524.767128493082, 19633.803661963375, 20926.476838079056, 20944.371668849923, 20954.952252387357, 20020.0990955407, 20389.878556679378, 20931.37205883822, 21211.151553937823, 21244.93775311236, 5807.0998995155815, 5937.317208521011, 5973.432523910222, 6024.9698751506185, 6028.4272994065495, 4220.324748040314, 4489.955100449003, 5989.0, 6500.382463665944, 6542.574732642387, 5498.45015498449, 5567.944320556803, 6345.0, 6398.488120950313, 6443.226812782473, 6278.246610406734, 6319.178506794134, 6417.0695249189075, 6447.451966582846, 6474.546781725281, 5589.161625756128, 5606.383297837235, 5613.382527921925, 5627.409122042209, 5627.521660658849, 24433.755662443327, 25544.36139096519, 25924.611130832865, 25983.740162598322, 25991.74008259931, 2060.5981833542464, 2161.9783802161933, 2181.727284089489, 2240.439890027493, 2516.496700659857, 9470.0, 9696.70909872705, 9895.307328487008, 9974.451405172713, 14220.92889535556, 1752.4304601004724, 1808.9547761305942, 1818.6635472437642, 1861.6410020684975, 1923.249932526316, 69442.65278673625, 70353.64823175903, 82947.0, 92725.0, 102113.4894325531, 10115.482677598418, 10381.480925953672, 11084.61203857861, 11248.156388270912, 11324.207305488537, 13507.0, 13547.119437236548, 13563.796543051862, 13564.389602467716, 13613.931930340284, 8442.480353536423, 8675.56622168889, 8675.566221689016, 8744.69393571222, 8790.780230494162, 8811.779705507413, 8833.911660883308, 8852.645894164161, 8936.955315223382, 8963.0, 4442.555744425532, 4504.6396288296855, 4511.548845115462, 4544.386507821402, 4556.931646025312, 1709.3077303692025, 1772.335374234662, 1829.378011476078, 1889.0932352470616, 1896.0993528074055, 698.5110422704128, 767.8118860879121, 901.7745563609097, 936.6768464879606, 1019.0573719309609, 15085.849141508445, 18110.456686299432, 20096.799032009785, 20313.289034884005, 20706.0, 959.5154447004218, 969.6606187834343, 973.250597040275, 978.3445091788519, 1018.7962407518378, 10597.258191926645, 11077.681337278887, 11137.99758021782, 11147.72130696739, 11184.832227516432, 602523.0, 602862.0, 607561.0, 617743.0, 619827.0, 112364.0, 112603.0, 112896.0, 114372.0, 115557.6888462226, 1020.3163880200284, 1029.5881647340973, 1050.175612144463, 1050.9579616815242, 1053.0995998421392, 17772.377966771102, 17815.73276400829, 18035.0080745555, 18425.53936151607, 18472.445826625222, 36097.63902360943, 47790.761046194544, 47962.0, 48082.27876581924, 48315.5168448311, 68400.0, 68527.3147268521, 68542.31457685558, 69712.60574788577, 70695.64652176706, 6569.37590928861, 6963.373296403145, 7235.421166306788, 7663.118741344594, 7990.081140668665, 10909.290896091728, 11978.981786547893, 12087.214331068453, 12241.632751017483, 12282.938585307016, 8638.91361086381, 10380.740481488023, 10532.315399499008, 10643.840342394715, 10786.352818830896, 8206.671733130608, 9963.850542241727, 10444.007819257158, 10483.318584291997, 10540.9986051325, 10615.256932014685, 10858.782824343627, 10964.671059868217, 10991.725206869573, 11075.556977721124, 6181.289151747606, 7548.1697013329585, 7616.124145723313, 7709.884351734616, 7938.206179382016, 9241.861372079558, 10548.841767373342, 10555.472226388803, 10805.837912431478, 10821.67534973952], "unit": "score", "name": "jquery.html", "value": 9197.049843528468}, {"lowerIsBetter": false, "replicates": [1433.3478267388339, 1570.4189449903538, 1605.3097168217669, 1883.5385330594006, 2018.4045706516577, 7905.881411778821, 8413.453125546843, 8535.445196062252, 8554.786130346745, 8555.10171432, 8277.296429803473, 8580.356473264514, 8581.656733730642, 8584.270337021346, 8591.625339945609, 2181.825453963679, 2406.362313986795, 2453.8159638027173, 2475.7276699563035, 2482.0816297969777, 2187.8796666183352, 2259.836184365053, 2437.1348171399163, 2437.244454219189, 2442.755724427561, 2320.7795259450327, 2357.2456813819585, 2393.3777217923293, 2395.556821987938, 2400.6159014557675, 2419.250032489934, 2464.667269918556, 2469.703635563726, 2475.0, 2480.7767300943, 2427.684401027873, 2471.8764061796837, 2485.142625794098, 2488.2410864686262, 2491.7757401833924, 8675.913240867574, 8729.388942774009, 8741.694040708608, 8759.78100547485, 8773.25427338677, 5325.334333208349, 5428.45715428458, 5435.592330575183, 5437.13005919055, 5483.2049352844015, 3363.764536482447, 3603.657652523006, 3680.9815950920342, 3684.4104943209227, 3691.427828686558, 896.3053633434075, 1038.4132964874898, 1044.3785947361307, 1065.6696424108552, 1079.3092420850662, 9716.95141524295, 11500.597479088192, 11671.1830171888, 11707.7073073173, 11716.414179291087, 4867.148249056472, 4914.33656456381, 4937.012597480519, 4975.402951645753, 5026.195808670595, 8266.214709602578, 10088.44513551747, 10125.898741012496, 10129.94935025335, 10180.134688551556, 5350.571954243651, 5355.410904800468, 5404.162354835007, 5424.403315635277, 5478.945210547923, 4354.107407981356, 4527.728336299832, 4742.4309082909585, 4848.10310092634, 4919.262110683355, 3866.4007078902814, 3956.2680904032845, 3959.5842436544326, 3978.104926391539, 4010.47863777707, 1286.4339690536135, 1304.5955753716378, 1305.2560040776857, 1319.2546211390534, 1320.6038188543398, 1146.5986904583497, 1162.924409913353, 1307.4508706343167, 1393.3590548347875, 1418.936147873348, 7400.370968467633, 7597.696092156362, 8128.715494957766, 8195.016598008158, 8204.712835050745, 513.1276829390052, 528.5164074871526, 530.5013287509729, 537.7472587883689, 539.4740128374804, 6210.913090209286, 6240.31356550779, 6249.375062493805, 6268.4671802897265, 6287.622742635456, 10194.898051019543, 10507.894921050845, 10607.787844243072, 10614.787704246026, 10626.043656070991, 10152.695419137437, 10297.0, 10305.227107966932, 10406.323588966692, 10473.47632618366, 8132.308753755997, 8187.426880118334, 8251.95874020626, 8261.917380826235, 8299.958500207582, 7686.46194766361, 7757.069151701832, 7800.960995194988, 7804.804879878048, 7839.294463498084, 9282.953585232031, 9287.210587100171, 9295.581698823704, 9385.953070234606, 9407.341486095907, 9007.234385077341, 9353.766155846159, 9514.524273786421, 9788.657396991071, 9791.51042447889, 6742.089817874524, 6932.896006559805, 7136.215016348094, 7333.413326933725, 7452.813679658052, 6699.39705426514, 8045.517268963881, 8064.072631647201, 8076.919230807852, 8097.514149151069, 6787.457003439614, 6952.374286314256, 7044.929550704633, 7204.71181152748, 7376.225496322809, 7079.221285658677, 7093.467989900882, 7195.244499327705, 7198.532095413991, 7207.0, 7476.626168691652, 7562.357199638092, 7610.467267291237, 7696.653650585625, 7696.8075798103255, 6941.757038503628, 6945.861082778417, 6990.056342393915, 6996.055532503047, 7001.159860816734, 7040.049593305043, 7053.4004609608755, 7122.0, 7143.749968751069, 7148.928510714826], "unit": "score", "name": "mootools.html", "value": 4772.179390365565}, {"lowerIsBetter": false, "replicates": [266.68397948431107, 328.83722557334124, 330.29152467956243, 333.42983498218047, 340.5929913753066, 5743.994800909845, 6459.967700161505, 6538.542302038853, 6548.345165483455, 6571.408573228408, 5714.285714285715, 5993.670348130851, 6389.0, 6493.220813502375, 6504.089427480145, 4558.544145585448, 4675.953240467603, 4681.368015317939, 4820.638452116088, 4823.469418363977, 4771.71369717818, 4773.57037866592, 4804.351412559295, 4807.23084306511, 4831.275308703687, 4758.857234282977, 4766.904661906759, 4769.666123371366, 4773.498782627827, 4775.5463230993, 4552.772361381918, 4621.121986822526, 4760.428748550179, 4772.355731976173, 4779.737114458703, 4051.311277082903, 4056.1076563156057, 4060.8984775380554, 4064.471618689581, 4067.410225517313, 6158.753649854, 6179.351168127327, 6180.969095154541, 6204.6587437690905, 6297.590656607306, 5482.205080263339, 5483.890322193573, 5484.369297530755, 5485.341758988947, 5505.504504594605, 6809.182898052216, 6829.317068293131, 6830.248672646005, 6834.521583489158, 6842.589444633288, 4287.442632457761, 4443.466783985942, 4451.5103338632725, 4480.462344518679, 4499.505054444008, 6091.690286588405, 7006.194287656934, 7179.246179151219, 7285.526440781386, 7298.306660867209, 4547.704399214107, 4549.727016379028, 4557.931631025537, 4558.680892337571, 4562.429696287964, 4603.194440972817, 4608.009278005245, 4616.446026476844, 4617.653675974316, 4625.190591646448, 5478.945210547923, 5481.369642491085, 5483.972580137074, 5484.698341591171, 5494.09347457673, 6613.0, 6842.281560436182, 6862.862742745217, 6906.792796216121, 6915.308469153045, 1579.068349673698, 1585.3024669145539, 1600.7518834580658, 1601.7677436771835, 1602.4872040947018, 970.2965350121106, 997.6258902911409, 1019.8062368150028, 1021.3301252452146, 1047.073340094007, 5331.786728530893, 6402.423781859655, 6503.512236582275, 6547.508936829661, 6609.7111063343145, 5498.367687715964, 7216.7113315466795, 7225.602591857393, 7233.168185658611, 7259.963700181571, 6547.607143571401, 6549.639769812706, 6568.244651865097, 6574.704138313788, 6591.472682185414, 3760.7743535387963, 3779.905502362463, 3799.5630502492013, 3799.810009499514, 3802.2205447883116, 6112.449879510866, 7272.781801550578, 7571.962140189264, 7605.771826845204, 7613.467057306047, 7358.632068396666, 7414.592197429085, 7414.888776668355, 7416.147143078615, 7420.666070026862, 6357.523185761086, 7272.0, 7531.246875312425, 7551.358134558624, 7553.546787192786, 6963.24004621922, 7176.569405835667, 7189.424846012411, 7198.89201661965, 7202.783916482514, 6976.372126508639, 7081.575105493687, 7092.468064895257, 7104.502684812013, 7116.288371163049, 6671.966640166962, 7492.175860655432, 7557.2820582044615, 7562.697492100255, 7569.810754731176, 4189.476315460567, 4535.31970204472, 4565.429321334833, 4574.0, 4582.679212455096, 7118.181409138016, 7132.572045677276, 7133.536320139175, 7134.750283740044, 7139.21468638439, 5604.915926261191, 6666.166729158856, 6831.760888368884, 6931.965340173267, 6966.407855332353, 5583.888322233452, 6862.691178896862, 6903.0, 6909.136357955255, 6927.064846245692, 5454.645448045864, 6756.966215168893, 6766.15423072116, 6771.3905748482875, 6773.153355830521, 6910.615837536042, 6912.654367281515, 6913.2049814272, 6917.481188910952, 6929.237783843874, 6486.902696459462, 6502.349765023649, 6620.404163625297, 6639.2696803352555, 6745.797626071226], "unit": "score", "name": "prototype.html", "value": 5008.468454325532}, {"lowerIsBetter": false, "replicates": [686.6978529447041, 695.2838576266444, 738.2838646512882, 758.908930928288, 776.5107981971357, 15100.697986040273, 15279.618009549768, 15298.2350882456, 15311.310991005405, 15317.310721017553, 13830.930845345785, 14332.570022899303, 14336.56990290293, 14359.425622975095, 14371.35328910199, 738.0737174845561, 738.5790099643206, 897.4929165021741, 904.7692838326251, 919.103873723118, 939.0515579264924, 940.4592359393342, 940.5485367023832, 941.665708673418, 943.7168849345203, 970.912617864392, 971.1453920549906, 974.7952929884733, 975.2636759246759, 977.3549457358109, 771.3250905457725, 957.5403806173007, 971.4608392342247, 972.4554249620236, 974.3179774158046, 727.7343769524139, 727.9745208917662, 728.5774250934498, 729.657061181244, 730.4886579394445, 12856.485740570366, 14340.56978290653, 15109.39562417502, 15153.893451842347, 15171.317290721943, 12370.44333005017, 12439.440225189888, 12498.312592807391, 12646.051546133986, 12748.107632465732, 9492.193163581034, 9585.233181345475, 10049.497525123714, 10116.848247276297, 10384.428856412895, 3495.056334789618, 3519.7360197985254, 3542.415501442259, 3586.946195807065, 3595.7123430125525, 78047.0, 79061.20938790595, 79165.81251281235, 79529.80705289425, 79989.40021199602, 9337.766555836022, 9387.249020078378, 9593.760155996157, 9670.323077384657, 10293.691189264335, 21939.67090493644, 22006.889965550068, 22391.664125038136, 22405.88797056004, 22407.55184896293, 7369.078865141857, 7517.736879209201, 7534.886976695354, 7626.504277221963, 7681.7695469136015, 3824.0822202671156, 3846.249981253629, 3953.5058117735284, 3958.6635136013188, 3970.4441378207075, 2920.8977685780897, 3629.8366573503727, 3632.473291372789, 3632.8546858125906, 3639.3085313790293, 632.8607706304606, 646.0116022485605, 653.6013032050446, 659.7558903205845, 660.8975608780647, 524.2686452398882, 595.8391234366696, 598.3418239936123, 599.6492052149541, 605.4218221598363, 7894.644740986554, 7986.7603971880935, 8102.51384916895, 8272.503649781032, 8314.750557483285, 573.263356586784, 589.548995018811, 590.2533295381346, 594.8334466349429, 600.0, 3711.2391959648207, 3727.5713292971113, 3772.8113594320175, 3826.4260360945523, 3900.941485877714, 80500.38999219982, 81011.0, 81041.0, 81185.59407202926, 84826.15173848307, 79287.0, 79627.60186199032, 80454.0, 80823.38353232903, 80994.59502702567, 64729.0, 65085.67457162684, 65872.34127658758, 66337.66831165813, 66558.99999999903, 7556.1310449299035, 7590.013298271189, 7610.315071643578, 7622.199669034671, 7800.219978002381, 46950.76524617355, 47892.76053619709, 48009.21930266574, 48088.79778005438, 48223.75888120537, 61200.0, 67039.65920681656, 67178.0, 67656.0, 68865.0, 8198.795030124294, 10023.498825058572, 10097.44464054484, 10262.948685256526, 10346.586136554453, 10739.838902416313, 10743.677689669323, 10785.676429707122, 10851.038528619045, 11109.388983605979, 10214.131798796889, 10248.692539223835, 10549.841752373874, 10558.04977552024, 10579.735506612396, 10375.533101010624, 10429.269951103654, 10508.264421490423, 10622.946885265525, 10642.787144257227, 9825.4104753715, 9872.703818885446, 9876.0, 10101.0, 10316.17470602365, 8355.781702085302, 8681.6093275804, 8713.651453941771, 8777.42946708462, 8958.283337332867, 8351.373646976623, 8562.74311770648, 8619.0, 8840.282976308157, 8841.0], "unit": "score", "name": "yui.html", "value": 6714.422521507292}], "name": "dromaeo_css", "value": 7349.04980061695}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [112.0, 110.0, 109.0, 111.0, 111.0, 110.0, 116.0, 111.0, 111.0, 109.0], "unit": "score", "name": "ai-astar", "value": 111.0}, {"lowerIsBetter": true, "replicates": [157.0, 120.0, 152.0, 193.0, 122.0, 142.0, 137.0, 119.0, 163.0, 119.0], "unit": "score", "name": "audio-beat-detection", "value": 142.4}, {"lowerIsBetter": true, "replicates": [185.0, 184.0, 189.0, 183.0, 186.0, 197.0, 186.0, 188.0, 184.0, 187.0], "unit": "score", "name": "audio-dft", "value": 186.9}, {"lowerIsBetter": true, "replicates": [75.0, 81.0, 84.0, 80.0, 57.0, 57.0, 60.0, 81.0, 88.0, 80.0], "unit": "score", "name": "audio-fft", "value": 74.3}, {"lowerIsBetter": true, "replicates": [88.0, 98.0, 125.0, 79.0, 77.0, 88.0, 114.0, 77.0, 80.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 94.1}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 90.0, 85.0, 88.0, 90.0, 88.0, 86.0, 88.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 87.3}, {"lowerIsBetter": true, "replicates": [92.0, 94.0, 94.0, 93.0, 93.0, 93.0, 94.0, 94.0, 93.0, 96.0], "unit": "score", "name": "imaging-darkroom", "value": 93.6}, {"lowerIsBetter": true, "replicates": [86.0, 87.0, 86.0, 86.0, 93.0, 135.0, 85.0, 87.0, 87.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 92.4}, {"lowerIsBetter": true, "replicates": [56.0, 54.0, 54.0, 53.0, 55.0, 54.0, 54.0, 66.0, 56.0, 53.0], "unit": "score", "name": "json-parse-financial", "value": 55.5}, {"lowerIsBetter": true, "replicates": [67.0, 62.0, 74.0, 73.0, 72.0, 70.0, 71.0, 69.0, 91.0, 62.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 71.1}, {"lowerIsBetter": true, "replicates": [83.0, 80.0, 83.0, 83.0, 81.0, 80.0, 83.0, 82.0, 83.0, 84.0], "unit": "score", "name": "stanford-crypto-aes", "value": 82.2}, {"lowerIsBetter": true, "replicates": [119.0, 137.0, 137.0, 130.0, 127.0, 125.0, 114.0, 120.0, 124.0, 127.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [140.0, 126.0, 141.0, 142.0, 136.0, 125.0, 140.0, 138.0, 142.0, 123.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 135.3}, {"lowerIsBetter": true, "replicates": [68.0, 66.0, 66.0, 68.0, 68.0, 69.0, 67.0, 69.0, 68.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 67.6}], "name": "kraken", "value": 1419.6999999999998}]} 04:58:32 INFO - Return code: 0 04:58:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:58:33 ERROR - # TBPL SUCCESS # 04:58:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:58:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:58:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:58:33 INFO - 2016-03-15 04:58:33.048 screenresolution[1972:20343] starting screenresolution argv=screenresolution get 04:58:33 INFO - 2016-03-15 04:58:33.051 screenresolution[1972:20343] Display 0: 1600x1200x32@60 04:58:33 INFO - 2016-03-15 04:58:33.057 screenresolution[1973:20346] starting screenresolution argv=screenresolution list 04:58:33 INFO - Available Modes on Display 0 04:58:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:58:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:58:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:58:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:58:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:58:33 INFO - Intel Iris: 04:58:33 INFO - Chipset Model: Intel Iris 04:58:33 INFO - Type: GPU 04:58:33 INFO - Bus: Built-In 04:58:33 INFO - VRAM (Dynamic, Max): 1536 MB 04:58:33 INFO - Vendor: Intel (0x8086) 04:58:33 INFO - Device ID: 0x0a2e 04:58:33 INFO - Revision ID: 0x0009 04:58:33 INFO - Displays: 04:58:33 INFO - Display: 04:58:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:58:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:58:33 INFO - Display Serial Number: 1600x1200 60 04:58:33 INFO - Main Display: Yes 04:58:33 INFO - Mirror: Off 04:58:33 INFO - Online: Yes 04:58:33 INFO - Rotation: Supported 04:58:33 INFO - Return code: 0 04:58:33 INFO - Running post-action listener: _resource_record_post_action 04:58:33 INFO - Running post-run listener: _resource_record_post_run 04:58:34 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 102400; Write bytes: 704133632; Read time: 4; Write time: 2201 04:58:34 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 402199040; Write bytes: 405032448; Read time: 30197; Write time: 785 04:58:34 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 102400; Write bytes: 298093568; Read time: 4; Write time: 1411 04:58:34 INFO - Running post-run listener: _upload_blobber_files 04:58:34 INFO - Blob upload gear active. 04:58:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:58:34 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 04:58:34 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'] 04:58:34 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 04:58:34 INFO - (blobuploader) - INFO - Open directory for files ... 04:58:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:58:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:58:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:35 INFO - (blobuploader) - INFO - Done attempting. 04:58:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:58:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:58:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:58:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:58:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:58:36 INFO - (blobuploader) - INFO - Done attempting. 04:58:36 INFO - (blobuploader) - INFO - Iteration through files over. 04:58:36 INFO - Return code: 0 04:58:36 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:58:36 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:58:36 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e599390ee60d8a785af276b9e330d1b3d9c8f4215237909727016487bc4067bcbeecd9614eaa49336c01f68cef2295c984e4afa982698574c2c0bafc5e89f8be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/35ddc5a90d5e795a9e29a94b007528b453e812d67f0e17e3135697d8cd97e6cb703a1f0faeb2c120767a582a77ca36a3e4187d4743fa2016109347e898187c8c"} 04:58:36 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:58:36 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:58:36 INFO - Contents: 04:58:36 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/e599390ee60d8a785af276b9e330d1b3d9c8f4215237909727016487bc4067bcbeecd9614eaa49336c01f68cef2295c984e4afa982698574c2c0bafc5e89f8be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/35ddc5a90d5e795a9e29a94b007528b453e812d67f0e17e3135697d8cd97e6cb703a1f0faeb2c120767a582a77ca36a3e4187d4743fa2016109347e898187c8c"} 04:58:36 INFO - Running post-run listener: copy_logs_to_upload_dir 04:58:36 INFO - Copying logs to upload dir... 04:58:36 INFO - mkdir: /builds/slave/test/build/upload/logs 04:58:36 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1265.136686 ========= master_lag: 0.08 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2016-03-15 04:58:36.900424) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 04:58:36.908175) ========= 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.yoE1R4uIio/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.e1ydnp1MK6/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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/e599390ee60d8a785af276b9e330d1b3d9c8f4215237909727016487bc4067bcbeecd9614eaa49336c01f68cef2295c984e4afa982698574c2c0bafc5e89f8be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/35ddc5a90d5e795a9e29a94b007528b453e812d67f0e17e3135697d8cd97e6cb703a1f0faeb2c120767a582a77ca36a3e4187d4743fa2016109347e898187c8c"} build_url:https://queue.taskcluster.net/v1/task/OD231tgdRiq8_LPGTqKcPw/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011041 build_url: 'https://queue.taskcluster.net/v1/task/OD231tgdRiq8_LPGTqKcPw/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/e599390ee60d8a785af276b9e330d1b3d9c8f4215237909727016487bc4067bcbeecd9614eaa49336c01f68cef2295c984e4afa982698574c2c0bafc5e89f8be", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/35ddc5a90d5e795a9e29a94b007528b453e812d67f0e17e3135697d8cd97e6cb703a1f0faeb2c120767a582a77ca36a3e4187d4743fa2016109347e898187c8c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-15 04:58:36.938121) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:58:36.938421) ========= 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.yoE1R4uIio/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.e1ydnp1MK6/Listeners TMPDIR=/var/folders/q3/qtb6pr455yg4tfb08p3q6f5h00000w/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.005311 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-03-15 04:58:36.986267) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 04:58:36.986551) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-15 04:58:36.989893) ========= ========= Total master_lag: 43.60 =========