builder: fx-team_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0113 starttime: 1459554993.74 results: success (0) buildid: 20160401142339 builduid: 98d505a5d7534830bc25aa94c3117c37 revision: 43f2fc45eaf759727dfed6893a8c2efc8c35ddf9 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:33.737987) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:33.738416) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:33.738702) ========= 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.b4rQM18gMX/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.9V5kUbaSaR/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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.005442 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:33.765512) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:33.765786) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:33.785629) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:33.785927) ========= 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.b4rQM18gMX/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.9V5kUbaSaR/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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.005052 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:33.835418) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:33.835682) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:33.836018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:33.836292) ========= 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.b4rQM18gMX/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.9V5kUbaSaR/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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-04-01 16:56:34-- 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% 19.1M=0.001s 2016-04-01 16:56:34 (19.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167589 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:34.024143) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:34.027477) ========= 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.b4rQM18gMX/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.9V5kUbaSaR/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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.026020 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:34.076903) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:34.077213) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 43f2fc45eaf759727dfed6893a8c2efc8c35ddf9 --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 43f2fc45eaf759727dfed6893a8c2efc8c35ddf9 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.b4rQM18gMX/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.9V5kUbaSaR/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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-04-01 16:56:34,748 truncating revision to first 12 chars 2016-04-01 16:56:34,748 Setting DEBUG logging. 2016-04-01 16:56:34,748 attempt 1/10 2016-04-01 16:56:34,748 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/43f2fc45eaf7?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-04-01 16:56:35,435 unpacking tar archive at: fx-team-43f2fc45eaf7/testing/mozharness/ program finished with exit code 0 elapsedTime=0.934165 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:35.032231) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:35.035607) ========= echo 43f2fc45eaf759727dfed6893a8c2efc8c35ddf9 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'43f2fc45eaf759727dfed6893a8c2efc8c35ddf9'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.b4rQM18gMX/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.9V5kUbaSaR/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 43f2fc45eaf759727dfed6893a8c2efc8c35ddf9 program finished with exit code 0 elapsedTime=0.004865 script_repo_revision: '43f2fc45eaf759727dfed6893a8c2efc8c35ddf9' ========= master_lag: 0.04 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:35.084907) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:35.085189) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-04-01 16:56:35.103685) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-04-01 16:56:35.103960) ========= /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.b4rQM18gMX/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.9V5kUbaSaR/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 16:56:35 INFO - MultiFileLogger online at 20160401 16:56:35 in /builds/slave/test 16:56:35 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 16:56:35 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:56:35 INFO - {'append_to_log': False, 16:56:35 INFO - 'base_work_dir': '/builds/slave/test', 16:56:35 INFO - 'blob_upload_branch': 'Fx-Team', 16:56:35 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:56:35 INFO - 'branch': 'Fx-Team', 16:56:35 INFO - 'buildbot_json_path': 'buildprops.json', 16:56:35 INFO - 'config_files': ('talos/mac_config.py',), 16:56:35 INFO - 'default_actions': ('clobber', 16:56:35 INFO - 'read-buildbot-config', 16:56:35 INFO - 'download-and-extract', 16:56:35 INFO - 'populate-webroot', 16:56:35 INFO - 'create-virtualenv', 16:56:35 INFO - 'install', 16:56:35 INFO - 'run-tests'), 16:56:35 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:56:35 INFO - 'download_minidump_stackwalk': True, 16:56:35 INFO - 'download_symbols': 'ondemand', 16:56:35 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:56:35 INFO - 'tooltool.py': '/tools/tooltool.py', 16:56:35 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:56:35 INFO - '/tools/misc-python/virtualenv.py')}, 16:56:35 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:56:35 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:56:35 INFO - 'installer_path': 'installer.exe', 16:56:35 INFO - 'log_level': 'info', 16:56:35 INFO - 'log_name': 'talos', 16:56:35 INFO - 'log_to_console': True, 16:56:35 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:56:35 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:56:35 INFO - 'opt_config_files': (), 16:56:35 INFO - 'pip_index': False, 16:56:35 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:56:35 INFO - 'cmd': ('bash', 16:56:35 INFO - '-c', 16:56:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:56:35 INFO - 'enabled': True, 16:56:35 INFO - 'halt_on_failure': False, 16:56:35 INFO - 'name': 'check_screen_resolution'},), 16:56:35 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:56:35 INFO - 'cmd': ('bash', 16:56:35 INFO - '-c', 16:56:35 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:56:35 INFO - 'enabled': True, 16:56:35 INFO - 'halt_on_failure': False, 16:56:35 INFO - 'name': 'check_screen_resolution'},), 16:56:35 INFO - 'run_cmd_checks_enabled': True, 16:56:35 INFO - 'sps_profile': False, 16:56:35 INFO - 'sps_profile_interval': 0, 16:56:35 INFO - 'suite': 'dromaeojs', 16:56:35 INFO - 'system_bits': '32', 16:56:35 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:56:35 INFO - 'title': 't-yosemite-r7-0113', 16:56:35 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:56:35 INFO - 'use_talos_json': True, 16:56:35 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:56:35 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:56:35 INFO - 'work_dir': 'build'} 16:56:35 INFO - ##### 16:56:35 INFO - ##### Running clobber step. 16:56:35 INFO - ##### 16:56:35 INFO - Running pre-action listener: _resource_record_pre_action 16:56:35 INFO - Running main action method: clobber 16:56:35 INFO - rmtree: /builds/slave/test/build 16:56:35 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:56:37 INFO - Running post-action listener: _resource_record_post_action 16:56:37 INFO - ##### 16:56:37 INFO - ##### Running read-buildbot-config step. 16:56:37 INFO - ##### 16:56:37 INFO - Running pre-action listener: _resource_record_pre_action 16:56:37 INFO - Running main action method: read_buildbot_config 16:56:37 INFO - Using buildbot properties: 16:56:37 INFO - { 16:56:37 INFO - "project": "", 16:56:37 INFO - "product": "firefox", 16:56:37 INFO - "script_repo_revision": "production", 16:56:37 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs", 16:56:37 INFO - "repository": "", 16:56:37 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs", 16:56:37 INFO - "buildid": "20160401142339", 16:56:37 INFO - "pgo_build": "False", 16:56:37 INFO - "basedir": "/builds/slave/test", 16:56:37 INFO - "buildnumber": 663, 16:56:37 INFO - "slavename": "t-yosemite-r7-0113", 16:56:37 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 16:56:37 INFO - "platform": "yosemite_r7", 16:56:37 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:56:37 INFO - "branch": "fx-team", 16:56:37 INFO - "repo_path": "integration/fx-team", 16:56:37 INFO - "revision": "43f2fc45eaf759727dfed6893a8c2efc8c35ddf9", 16:56:37 INFO - "stage_platform": "macosx64", 16:56:37 INFO - "builduid": "98d505a5d7534830bc25aa94c3117c37", 16:56:37 INFO - "slavebuilddir": "test" 16:56:37 INFO - } 16:56:37 INFO - Found installer url https://queue.taskcluster.net/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg. 16:56:37 INFO - Running post-action listener: _resource_record_post_action 16:56:37 INFO - ##### 16:56:37 INFO - ##### Running download-and-extract step. 16:56:37 INFO - ##### 16:56:37 INFO - Running pre-action listener: _resource_record_pre_action 16:56:37 INFO - Running main action method: download_and_extract 16:56:37 INFO - mkdir: /builds/slave/test/build/tests 16:56:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:37 INFO - https://queue.taskcluster.net/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json matches https://queue.taskcluster.net 16:56:37 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 16:56:37 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.test_packages.json 16:56:37 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/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 16:56:37 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/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 16:56:39 INFO - Downloaded 1199 bytes. 16:56:39 INFO - Reading from file /builds/slave/test/build/firefox-48.0a1.en-US.mac.test_packages.json 16:56:39 INFO - Using the following test package requirements: 16:56:39 INFO - {u'common': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 16:56:39 INFO - u'cppunittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:56:39 INFO - u'firefox-48.0a1.en-US.mac.cppunittest.tests.zip'], 16:56:39 INFO - u'gtest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:56:39 INFO - u'firefox-48.0a1.en-US.mac.gtest.tests.zip'], 16:56:39 INFO - u'jittest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:56:39 INFO - u'jsshell-mac.zip'], 16:56:39 INFO - u'mochitest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:56:39 INFO - u'firefox-48.0a1.en-US.mac.mochitest.tests.zip'], 16:56:39 INFO - u'mozbase': [u'firefox-48.0a1.en-US.mac.common.tests.zip'], 16:56:39 INFO - u'reftest': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:56:39 INFO - u'firefox-48.0a1.en-US.mac.reftest.tests.zip'], 16:56:39 INFO - u'talos': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:56:39 INFO - u'firefox-48.0a1.en-US.mac.talos.tests.zip'], 16:56:39 INFO - u'web-platform': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:56:39 INFO - u'firefox-48.0a1.en-US.mac.web-platform.tests.zip'], 16:56:39 INFO - u'xpcshell': [u'firefox-48.0a1.en-US.mac.common.tests.zip', 16:56:39 INFO - u'firefox-48.0a1.en-US.mac.xpcshell.tests.zip']} 16:56:39 INFO - Downloading packages: [u'firefox-48.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:56:39 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')]} 16:56:39 INFO - https://queue.taskcluster.net/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:56:39 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:56:39 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:56:39 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/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 16:56:39 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/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 16:56:44 INFO - Downloaded 17956353 bytes. 16:56:44 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'] 16:56:44 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 16:56:47 INFO - Return code: 0 16:56:47 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 16:56:47 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')]} 16:56:47 INFO - https://queue.taskcluster.net/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:56:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:56:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.common.tests.zip 16:56:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/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 16:56:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/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 16:56:49 INFO - Downloaded 17956353 bytes. 16:56:49 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'] 16:56:49 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 16:56:53 INFO - Return code: 0 16:56:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:53 INFO - https://queue.taskcluster.net/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:56:53 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:56:53 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.talos.tests.zip 16:56:53 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/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 16:56:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/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 16:56:54 INFO - Downloaded 10847534 bytes. 16:56:54 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'] 16:56:54 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 16:56:54 INFO - Return code: 0 16:56:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:56:54 INFO - https://queue.taskcluster.net/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:56:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:56:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:56:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0a1.en-US.mac.dmg 16:56:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Jqzc4hZBRi-nmq27DXnoKA/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 16:56:58 INFO - Downloaded 111467293 bytes. 16:56:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:56:58 INFO - mkdir: /builds/slave/test/properties 16:56:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:56:58 INFO - Writing to file /builds/slave/test/properties/build_url 16:56:58 INFO - Contents: 16:56:58 INFO - build_url:https://queue.taskcluster.net/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg 16:57:00 INFO - Running post-action listener: _resource_record_post_action 16:57:00 INFO - Running post-action listener: set_extra_try_arguments 16:57:00 INFO - ##### 16:57:00 INFO - ##### Running populate-webroot step. 16:57:00 INFO - ##### 16:57:00 INFO - Running pre-action listener: _resource_record_pre_action 16:57:00 INFO - Running main action method: populate_webroot 16:57:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:57:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:57:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:57:00 INFO - '--tppagecycles', 16:57:00 INFO - '7'], 16:57:00 INFO - 'tests': ['tsvgm']}}, 16:57:00 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:57:00 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:57:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:57:00 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 16:57:00 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:57:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 16:57:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:00 INFO - 'talos_options': ['--e10s'], 16:57:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:57:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:00 INFO - 'tests': ['damp', 'tps']}, 16:57:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:00 INFO - 'talos_options': ['--e10s'], 16:57:00 INFO - 'tests': ['damp', 'tps']}, 16:57:00 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:57:00 INFO - 'g3-e10s': {'talos_options': ['--e10s'], 16:57:00 INFO - 'tests': ['dromaeo_dom']}, 16:57:00 INFO - 'other': {'tests': ['a11yr', 16:57:00 INFO - 'ts_paint', 16:57:00 INFO - 'tpaint', 16:57:00 INFO - 'sessionrestore', 16:57:00 INFO - 'sessionrestore_no_auto_restore', 16:57:00 INFO - 'tabpaint']}, 16:57:00 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:57:00 INFO - 'tests': ['a11yr', 16:57:00 INFO - 'ts_paint', 16:57:00 INFO - 'tpaint', 16:57:00 INFO - 'sessionrestore', 16:57:00 INFO - 'sessionrestore_no_auto_restore', 16:57:00 INFO - 'tabpaint']}, 16:57:00 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:57:00 INFO - 'tests': ['a11yr', 16:57:00 INFO - 'ts_paint', 16:57:00 INFO - 'tpaint', 16:57:00 INFO - 'sessionrestore', 16:57:00 INFO - 'sessionrestore_no_auto_restore', 16:57:00 INFO - 'tabpaint']}, 16:57:00 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:57:00 INFO - 'tests': ['a11yr', 16:57:00 INFO - 'ts_paint', 16:57:00 INFO - 'tpaint', 16:57:00 INFO - 'sessionrestore', 16:57:00 INFO - 'sessionrestore_no_auto_restore', 16:57:00 INFO - 'tabpaint']}, 16:57:00 INFO - 'other_l64': {'tests': ['a11yr', 16:57:00 INFO - 'ts_paint', 16:57:00 INFO - 'tpaint', 16:57:00 INFO - 'sessionrestore', 16:57:00 INFO - 'sessionrestore_no_auto_restore', 16:57:00 INFO - 'tabpaint']}, 16:57:00 INFO - 'other_nol64': {'tests': ['a11yr', 16:57:00 INFO - 'ts_paint', 16:57:00 INFO - 'tpaint', 16:57:00 INFO - 'sessionrestore', 16:57:00 INFO - 'sessionrestore_no_auto_restore', 16:57:00 INFO - 'tabpaint']}, 16:57:00 INFO - 'svgr': {'tests': ['tsvgx', 16:57:00 INFO - 'tsvgr_opacity', 16:57:00 INFO - 'tart', 16:57:00 INFO - 'tscrollx', 16:57:00 INFO - 'cart']}, 16:57:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:57:00 INFO - 'tests': ['tsvgx', 16:57:00 INFO - 'tsvgr_opacity', 16:57:00 INFO - 'tart', 16:57:00 INFO - 'tscrollx', 16:57:00 INFO - 'cart']}, 16:57:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:00 INFO - 'tests': ['tp5o']}, 16:57:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:00 INFO - 'talos_options': ['--e10s'], 16:57:00 INFO - 'tests': ['tp5o']}, 16:57:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:00 INFO - 'talos_options': ['--xperf_path', 16:57:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:00 INFO - 'tests': ['tp5n']}, 16:57:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:57:00 INFO - 'talos_options': ['--e10s', 16:57:00 INFO - '--xperf_path', 16:57:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:57:00 INFO - 'tests': ['tp5n']}}, 16:57:00 INFO - 'talos.zip': {'path': '', 16:57:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:57:00 INFO - Running post-action listener: _resource_record_post_action 16:57:00 INFO - ##### 16:57:00 INFO - ##### Running create-virtualenv step. 16:57:00 INFO - ##### 16:57:00 INFO - Running pre-action listener: _resource_record_pre_action 16:57:00 INFO - Running main action method: create_virtualenv 16:57:00 INFO - Creating virtualenv /builds/slave/test/build/venv 16:57:00 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 16:57:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:57:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:57:00 INFO - Using real prefix '/tools/python27' 16:57:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:57:01 INFO - Installing distribute.............................................................................................................................................................................................done. 16:57:03 INFO - Installing pip.................done. 16:57:03 INFO - Return code: 0 16:57:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f714a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f724420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ebbda48a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b3e00>, '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 0x10f3dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5aeb20>, '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.b4rQM18gMX/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.9V5kUbaSaR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 16:57: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', 'pip>=1.5'] in /builds/slave/test/build 16:57: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 pip>=1.5 16:57:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4rQM18gMX/Render', 16:57:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:03 INFO - 'HOME': '/Users/cltbld', 16:57:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:03 INFO - 'LOGNAME': 'cltbld', 16:57:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:03 INFO - 'MOZ_NO_REMOTE': '1', 16:57:03 INFO - 'NO_EM_RESTART': '1', 16:57:03 INFO - 'PAGER': '/bin/cat', 16:57:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:03 INFO - 'PWD': '/builds/slave/test', 16:57:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:03 INFO - 'SHELL': '/bin/bash', 16:57:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9V5kUbaSaR/Listeners', 16:57:03 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 16:57:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:03 INFO - 'USER': 'cltbld', 16:57:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:03 INFO - 'XPC_FLAGS': '0x0', 16:57:03 INFO - 'XPC_SERVICE_NAME': '0', 16:57:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:04 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 16:57:04 INFO - Cleaning up... 16:57:04 INFO - Return code: 0 16:57:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:04 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 0x10f714a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f724420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ebbda48a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b3e00>, '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 0x10f3dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5aeb20>, '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.b4rQM18gMX/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.9V5kUbaSaR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 16:57:04 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 16:57:04 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 16:57:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4rQM18gMX/Render', 16:57:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:04 INFO - 'HOME': '/Users/cltbld', 16:57:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:04 INFO - 'LOGNAME': 'cltbld', 16:57:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:04 INFO - 'MOZ_NO_REMOTE': '1', 16:57:04 INFO - 'NO_EM_RESTART': '1', 16:57:04 INFO - 'PAGER': '/bin/cat', 16:57:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:04 INFO - 'PWD': '/builds/slave/test', 16:57:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:04 INFO - 'SHELL': '/bin/bash', 16:57:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9V5kUbaSaR/Listeners', 16:57:04 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 16:57:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:04 INFO - 'USER': 'cltbld', 16:57:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:04 INFO - 'XPC_FLAGS': '0x0', 16:57:04 INFO - 'XPC_SERVICE_NAME': '0', 16:57:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:04 INFO - Downloading/unpacking psutil>=0.7.1 16:57:04 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 16:57:04 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 16:57:04 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 16:57:04 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 16:57:04 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 16:57:04 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 16:57:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:57:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:07 INFO - Installing collected packages: psutil 16:57:07 INFO - Running setup.py install for psutil 16:57:07 INFO - building 'psutil._psutil_osx' extension 16:57:07 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 16:57:07 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 16:57:07 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 16:57:07 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 16:57:08 INFO - building 'psutil._psutil_posix' extension 16:57:08 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 16:57:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:57:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:57:08 INFO - ^ 16:57:08 INFO - 1 warning generated. 16:57:08 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 16:57:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:57:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:57:08 INFO - Successfully installed psutil 16:57:08 INFO - Cleaning up... 16:57:08 INFO - Return code: 0 16:57:08 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:57: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')]} 16:57:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57: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')]} 16:57:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:08 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 0x10f714a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f724420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ebbda48a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b3e00>, '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 0x10f3dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5aeb20>, '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.b4rQM18gMX/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.9V5kUbaSaR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 16:57:08 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 16:57:08 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 16:57:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4rQM18gMX/Render', 16:57:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:08 INFO - 'HOME': '/Users/cltbld', 16:57:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:08 INFO - 'LOGNAME': 'cltbld', 16:57:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:08 INFO - 'MOZ_NO_REMOTE': '1', 16:57:08 INFO - 'NO_EM_RESTART': '1', 16:57:08 INFO - 'PAGER': '/bin/cat', 16:57:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:08 INFO - 'PWD': '/builds/slave/test', 16:57:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:08 INFO - 'SHELL': '/bin/bash', 16:57:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9V5kUbaSaR/Listeners', 16:57:08 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 16:57:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:08 INFO - 'USER': 'cltbld', 16:57:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:08 INFO - 'XPC_FLAGS': '0x0', 16:57:08 INFO - 'XPC_SERVICE_NAME': '0', 16:57:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:08 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:57:08 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 16:57:08 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 16:57:08 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 16:57:08 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 16:57:08 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 16:57:08 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 16:57:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:57:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:57:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:57:11 INFO - Installing collected packages: mozsystemmonitor 16:57:11 INFO - Running setup.py install for mozsystemmonitor 16:57:11 INFO - Successfully installed mozsystemmonitor 16:57:11 INFO - Cleaning up... 16:57:11 INFO - Return code: 0 16:57:11 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:11 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 0x10f714a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f724420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ebbda48a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b3e00>, '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 0x10f3dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5aeb20>, '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.b4rQM18gMX/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.9V5kUbaSaR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 16:57:11 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 16:57:11 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 16:57:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4rQM18gMX/Render', 16:57:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:11 INFO - 'HOME': '/Users/cltbld', 16:57:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:11 INFO - 'LOGNAME': 'cltbld', 16:57:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:11 INFO - 'MOZ_NO_REMOTE': '1', 16:57:11 INFO - 'NO_EM_RESTART': '1', 16:57:11 INFO - 'PAGER': '/bin/cat', 16:57:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:11 INFO - 'PWD': '/builds/slave/test', 16:57:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:11 INFO - 'SHELL': '/bin/bash', 16:57:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9V5kUbaSaR/Listeners', 16:57:11 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 16:57:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:11 INFO - 'USER': 'cltbld', 16:57:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:11 INFO - 'XPC_FLAGS': '0x0', 16:57:11 INFO - 'XPC_SERVICE_NAME': '0', 16:57:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:11 INFO - Downloading/unpacking blobuploader==1.2.4 16:57:11 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 16:57:11 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 16:57:11 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 16:57:11 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 16:57:11 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 16:57:11 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 16:57:14 INFO - Downloading blobuploader-1.2.4.tar.gz 16:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:57:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:57:14 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:14 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:14 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:57:14 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:57:14 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:57:15 INFO - Downloading docopt-0.6.1.tar.gz 16:57:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:57:15 INFO - Installing collected packages: blobuploader, requests, docopt 16:57:15 INFO - Running setup.py install for blobuploader 16:57:15 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:57:15 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:57:15 INFO - Running setup.py install for requests 16:57:16 INFO - Running setup.py install for docopt 16:57:16 INFO - Successfully installed blobuploader requests docopt 16:57:16 INFO - Cleaning up... 16:57:16 INFO - Return code: 0 16:57:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:16 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 0x10f714a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f724420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ebbda48a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b3e00>, '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 0x10f3dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5aeb20>, '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.b4rQM18gMX/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.9V5kUbaSaR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 16:57:16 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 16:57:16 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 16:57:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4rQM18gMX/Render', 16:57:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:16 INFO - 'HOME': '/Users/cltbld', 16:57:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:16 INFO - 'LOGNAME': 'cltbld', 16:57:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:16 INFO - 'MOZ_NO_REMOTE': '1', 16:57:16 INFO - 'NO_EM_RESTART': '1', 16:57:16 INFO - 'PAGER': '/bin/cat', 16:57:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:16 INFO - 'PWD': '/builds/slave/test', 16:57:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:16 INFO - 'SHELL': '/bin/bash', 16:57:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9V5kUbaSaR/Listeners', 16:57:16 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 16:57:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:16 INFO - 'USER': 'cltbld', 16:57:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:16 INFO - 'XPC_FLAGS': '0x0', 16:57:16 INFO - 'XPC_SERVICE_NAME': '0', 16:57:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:57:16 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-NsCdn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:57:16 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-lSej_4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:57:16 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-ijoQMR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:57:16 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-dyfcKt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:57:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:57:16 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-_p72KM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:57:17 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-RCrhlK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:57:17 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-eDSM4n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:57:17 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-TouVhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:57:17 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-yHVd7E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:57:17 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-hmBG7t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:57:17 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-m0bSQ2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:57:17 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-tGr1Kz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:57:17 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-HEJYze-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:57:17 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-K7zSAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:57:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:17 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-KpnnYZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:57:18 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-6bMGtL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:57:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:57:18 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-3EDn3I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:57:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:57:18 INFO - Running setup.py install for manifestparser 16:57:18 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:57:18 INFO - Running setup.py install for mozcrash 16:57:18 INFO - Running setup.py install for mozdebug 16:57:18 INFO - Running setup.py install for mozdevice 16:57:18 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:57:18 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:57:18 INFO - Running setup.py install for mozfile 16:57:18 INFO - Running setup.py install for mozhttpd 16:57:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:57:19 INFO - Running setup.py install for mozinfo 16:57:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:57:19 INFO - Running setup.py install for mozInstall 16:57:19 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:57:19 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:57:19 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:57:19 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:57:19 INFO - Running setup.py install for mozleak 16:57:19 INFO - Running setup.py install for mozlog 16:57:19 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:57:19 INFO - Running setup.py install for moznetwork 16:57:19 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:57:19 INFO - Running setup.py install for mozprocess 16:57:19 INFO - Running setup.py install for mozprofile 16:57:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:57:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:57:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:57:20 INFO - Running setup.py install for mozrunner 16:57:20 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:57:20 INFO - Running setup.py install for mozscreenshot 16:57:20 INFO - Running setup.py install for moztest 16:57:20 INFO - Running setup.py install for mozversion 16:57:20 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:57:20 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:57:20 INFO - Cleaning up... 16:57:20 INFO - Return code: 0 16:57:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:20 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 0x10f714a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f724420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ebbda48a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b3e00>, '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 0x10f3dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5aeb20>, '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.b4rQM18gMX/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.9V5kUbaSaR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 16:57:20 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 16:57:20 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 16:57:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4rQM18gMX/Render', 16:57:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:20 INFO - 'HOME': '/Users/cltbld', 16:57:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:20 INFO - 'LOGNAME': 'cltbld', 16:57:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:20 INFO - 'MOZ_NO_REMOTE': '1', 16:57:20 INFO - 'NO_EM_RESTART': '1', 16:57:20 INFO - 'PAGER': '/bin/cat', 16:57:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:20 INFO - 'PWD': '/builds/slave/test', 16:57:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:20 INFO - 'SHELL': '/bin/bash', 16:57:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9V5kUbaSaR/Listeners', 16:57:20 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 16:57:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:20 INFO - 'USER': 'cltbld', 16:57:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:20 INFO - 'XPC_FLAGS': '0x0', 16:57:20 INFO - 'XPC_SERVICE_NAME': '0', 16:57:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:57:21 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-RrVedS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:57:21 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)) 16:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:57:21 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-EvreQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:57:21 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)) 16:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:57:21 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-3sSSwc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:57:21 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)) 16:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:57:21 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-JFkpEV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:57:21 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)) 16:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:57:21 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-qN0z2Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:57:21 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)) 16:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:57:21 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-QFqt5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:57:21 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)) 16:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:57:21 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-FDbUoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:57:21 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)) 16:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:57:21 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-k48Ein-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:57:21 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)) 16:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:57:21 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-w8KP4v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:57:21 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)) 16:57:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:57:21 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-a0aCDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:57:22 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)) 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:57:22 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-Svucsq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:57:22 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)) 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:57:22 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-rar37B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:57:22 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)) 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:57:22 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-QjLckF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:57:22 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)) 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:57:22 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-dRWsvd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:57:22 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)) 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:22 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-ajnJn_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:57:22 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)) 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:57:22 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-WZTLJL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:57:22 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)) 16:57:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:57:22 INFO - Running setup.py (path:/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/pip-nbV5yw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:57:22 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)) 16:57:22 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)) 16:57:22 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)) 16:57:22 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)) 16:57:22 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)) 16:57:22 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)) 16:57:22 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:57:22 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 16:57:22 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 16:57:22 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 16:57:22 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 16:57:22 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 16:57:22 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 16:57:25 INFO - Downloading blessings-1.6.tar.gz 16:57:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:57:25 INFO - Installing collected packages: blessings 16:57:25 INFO - Running setup.py install for blessings 16:57:25 INFO - Successfully installed blessings 16:57:25 INFO - Cleaning up... 16:57:25 INFO - Return code: 0 16:57:25 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:57:25 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:57:25 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:57:26 INFO - Reading from file tmpfile_stdout 16:57:26 INFO - Current package versions: 16:57:26 INFO - blessings == 1.6 16:57:26 INFO - blobuploader == 1.2.4 16:57:26 INFO - docopt == 0.6.1 16:57:26 INFO - manifestparser == 1.1 16:57:26 INFO - mozInstall == 1.12 16:57:26 INFO - mozcrash == 0.17 16:57:26 INFO - mozdebug == 0.1 16:57:26 INFO - mozdevice == 0.48 16:57:26 INFO - mozfile == 1.2 16:57:26 INFO - mozhttpd == 0.7 16:57:26 INFO - mozinfo == 0.9 16:57:26 INFO - mozleak == 0.1 16:57:26 INFO - mozlog == 3.1 16:57:26 INFO - moznetwork == 0.27 16:57:26 INFO - mozprocess == 0.22 16:57:26 INFO - mozprofile == 0.28 16:57:26 INFO - mozrunner == 6.11 16:57:26 INFO - mozscreenshot == 0.1 16:57:26 INFO - mozsystemmonitor == 0.0 16:57:26 INFO - moztest == 0.7 16:57:26 INFO - mozversion == 1.4 16:57:26 INFO - psutil == 3.1.1 16:57:26 INFO - requests == 1.2.3 16:57:26 INFO - wsgiref == 0.1.2 16:57:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:57:26 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')]} 16:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:26 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')]} 16:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:26 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 0x10f714a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f724420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ebbda48a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b3e00>, '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 0x10f3dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5aeb20>, '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.b4rQM18gMX/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.9V5kUbaSaR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 16:57:26 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 16:57:26 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 16:57:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4rQM18gMX/Render', 16:57:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:26 INFO - 'HOME': '/Users/cltbld', 16:57:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:26 INFO - 'LOGNAME': 'cltbld', 16:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:26 INFO - 'MOZ_NO_REMOTE': '1', 16:57:26 INFO - 'NO_EM_RESTART': '1', 16:57:26 INFO - 'PAGER': '/bin/cat', 16:57:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:26 INFO - 'PWD': '/builds/slave/test', 16:57:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:26 INFO - 'SHELL': '/bin/bash', 16:57:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9V5kUbaSaR/Listeners', 16:57:26 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 16:57:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:26 INFO - 'USER': 'cltbld', 16:57:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:26 INFO - 'XPC_FLAGS': '0x0', 16:57:26 INFO - 'XPC_SERVICE_NAME': '0', 16:57:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:26 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)) 16:57:26 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)) 16:57:26 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)) 16:57:26 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)) 16:57:26 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)) 16:57:26 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)) 16:57:26 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)) 16:57:26 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)) 16:57:26 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)) 16:57:26 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)) 16:57:26 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)) 16:57:26 INFO - Cleaning up... 16:57:26 INFO - Return code: 0 16:57:26 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 16:57:26 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')]} 16:57:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:26 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')]} 16:57:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:26 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 0x10f714a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f724420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ebbda48a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b3e00>, '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 0x10f3dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5aeb20>, '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.b4rQM18gMX/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.9V5kUbaSaR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 16:57:26 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 16:57:26 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 16:57:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4rQM18gMX/Render', 16:57:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:26 INFO - 'HOME': '/Users/cltbld', 16:57:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:26 INFO - 'LOGNAME': 'cltbld', 16:57:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:26 INFO - 'MOZ_NO_REMOTE': '1', 16:57:26 INFO - 'NO_EM_RESTART': '1', 16:57:26 INFO - 'PAGER': '/bin/cat', 16:57:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:26 INFO - 'PWD': '/builds/slave/test', 16:57:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:26 INFO - 'SHELL': '/bin/bash', 16:57:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9V5kUbaSaR/Listeners', 16:57:26 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 16:57:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:26 INFO - 'USER': 'cltbld', 16:57:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:26 INFO - 'XPC_FLAGS': '0x0', 16:57:26 INFO - 'XPC_SERVICE_NAME': '0', 16:57:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:26 INFO - Downloading/unpacking jsonschema 16:57:26 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 16:57:26 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 16:57:26 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 16:57:26 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 16:57:26 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 16:57:26 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 16:57:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 16:57:29 INFO - Downloading/unpacking functools32 (from jsonschema) 16:57:29 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 16:57:29 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 16:57:29 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 16:57:29 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 16:57:29 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 16:57:29 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 16:57:29 INFO - Downloading functools32-3.2.3-2.tar.gz 16:57:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 16:57:29 INFO - warning: no files found matching '*.txt' 16:57:29 INFO - no previously-included directories found matching 'build' 16:57:29 INFO - no previously-included directories found matching 'dist' 16:57:29 INFO - no previously-included directories found matching '.git*' 16:57:29 INFO - Installing collected packages: jsonschema, functools32 16:57:29 INFO - Running setup.py install for functools32 16:57:29 INFO - warning: no files found matching '*.txt' 16:57:29 INFO - no previously-included directories found matching 'build' 16:57:29 INFO - no previously-included directories found matching 'dist' 16:57:29 INFO - no previously-included directories found matching '.git*' 16:57:29 INFO - Successfully installed jsonschema functools32 16:57:29 INFO - Cleaning up... 16:57:29 INFO - Return code: 0 16:57:29 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 16:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:57:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:57:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:57:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:57:29 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 0x10f714a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f724420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8ebbda48a0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f5b3e00>, '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 0x10f3dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5aeb20>, '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.b4rQM18gMX/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.9V5kUbaSaR/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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 16:57:29 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 16:57:29 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 16:57:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4rQM18gMX/Render', 16:57:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:57:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:57:29 INFO - 'HOME': '/Users/cltbld', 16:57:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:57:29 INFO - 'LOGNAME': 'cltbld', 16:57:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:57:29 INFO - 'MOZ_NO_REMOTE': '1', 16:57:29 INFO - 'NO_EM_RESTART': '1', 16:57:29 INFO - 'PAGER': '/bin/cat', 16:57:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:57:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:57:29 INFO - 'PWD': '/builds/slave/test', 16:57:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:57:29 INFO - 'SHELL': '/bin/bash', 16:57:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9V5kUbaSaR/Listeners', 16:57:29 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 16:57:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:57:29 INFO - 'USER': 'cltbld', 16:57:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:57:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:57:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:57:29 INFO - 'XPC_FLAGS': '0x0', 16:57:29 INFO - 'XPC_SERVICE_NAME': '0', 16:57:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:57:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:57:30 INFO - Downloading/unpacking flake8 16:57:30 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 16:57:30 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 16:57:30 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 16:57:30 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 16:57:30 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 16:57:30 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 16:57:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 16:57:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 16:57:33 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 16:57:33 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 16:57:33 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 16:57:33 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 16:57:33 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 16:57:33 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 16:57:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 16:57:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 16:57:33 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 16:57:33 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 16:57:33 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 16:57:33 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 16:57:33 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 16:57:33 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 16:57:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 16:57:34 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 16:57:34 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 16:57:34 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 16:57:34 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 16:57:34 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 16:57:34 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 16:57:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 16:57:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:57:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:57:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:57:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:57:34 INFO - no previously-included directories found matching 'docs/_build' 16:57:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 16:57:34 INFO - Running setup.py install for pep8 16:57:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 16:57:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 16:57:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 16:57:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 16:57:34 INFO - no previously-included directories found matching 'docs/_build' 16:57:34 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 16:57:34 INFO - Successfully installed flake8 mccabe pyflakes pep8 16:57:34 INFO - Cleaning up... 16:57:35 INFO - Return code: 0 16:57:35 INFO - Running post-action listener: _resource_record_post_action 16:57:35 INFO - Running post-action listener: _start_resource_monitoring 16:57:35 INFO - Starting resource monitoring. 16:57:35 INFO - ##### 16:57:35 INFO - ##### Running install step. 16:57:35 INFO - ##### 16:57:35 INFO - Running pre-action listener: _resource_record_pre_action 16:57:35 INFO - Running main action method: install 16:57:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:57:35 INFO - Reading from file tmpfile_stdout 16:57:35 INFO - Detecting whether we're running mozinstall >=1.0... 16:57:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:57:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:57:35 INFO - Reading from file tmpfile_stdout 16:57:35 INFO - Output received: 16:57:35 INFO - Usage: mozinstall [options] installer 16:57:35 INFO - Options: 16:57:35 INFO - -h, --help show this help message and exit 16:57:35 INFO - -d DEST, --destination=DEST 16:57:35 INFO - Directory to install application into. [default: 16:57:35 INFO - "/builds/slave/test"] 16:57:35 INFO - --app=APP Application being installed. [default: firefox] 16:57:35 INFO - mkdir: /builds/slave/test/build/application 16:57:35 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'] 16:57:35 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 16:58:09 INFO - Reading from file tmpfile_stdout 16:58:09 INFO - Output received: 16:58:09 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:58:09 INFO - Running post-action listener: _resource_record_post_action 16:58:09 INFO - ##### 16:58:09 INFO - ##### Running run-tests step. 16:58:09 INFO - ##### 16:58:09 INFO - Running pre-action listener: _resource_record_pre_action 16:58:09 INFO - Running main action method: run_tests 16:58:09 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:58:09 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:58:09 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:58:09 INFO - 2016-04-01 16:58:09.326 screenresolution[1640:7525] starting screenresolution argv=screenresolution get 16:58:09 INFO - 2016-04-01 16:58:09.329 screenresolution[1640:7525] Display 0: 1600x1200x32@60 16:58:09 INFO - 2016-04-01 16:58:09.334 screenresolution[1641:7527] starting screenresolution argv=screenresolution list 16:58:09 INFO - Available Modes on Display 0 16:58:09 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:58:09 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:58:09 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:58:09 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:58:09 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:58:09 INFO - Intel Iris: 16:58:09 INFO - Chipset Model: Intel Iris 16:58:09 INFO - Type: GPU 16:58:09 INFO - Bus: Built-In 16:58:09 INFO - VRAM (Dynamic, Max): 1536 MB 16:58:09 INFO - Vendor: Intel (0x8086) 16:58:09 INFO - Device ID: 0x0a2e 16:58:09 INFO - Revision ID: 0x0009 16:58:09 INFO - Displays: 16:58:09 INFO - Display: 16:58:09 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:58:09 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:58:09 INFO - Display Serial Number: 1600x1200 60 16:58:09 INFO - Main Display: Yes 16:58:09 INFO - Mirror: Off 16:58:09 INFO - Online: Yes 16:58:09 INFO - Rotation: Supported 16:58:09 INFO - Return code: 0 16:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:58:09 INFO - Python 2.7.3 16:58:09 INFO - Return code: 0 16:58:09 INFO - grabbing minidump binary from tooltool 16:58:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:58:09 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 0x10f5b3e00>, '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 0x10f3dcdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f5aeb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:58:09 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 16:58:09 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 16:58:09 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:58:09 INFO - Return code: 0 16:58:09 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:58:09 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:58:09 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:58:09 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:58:09 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:58:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 16:58:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 16:58:10 INFO - Return code: 0 16:58:10 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/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0113', '--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 16:58:10 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/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0113 --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 16:58:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.b4rQM18gMX/Render', 16:58:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:58:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:58:10 INFO - 'HOME': '/Users/cltbld', 16:58:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:58:10 INFO - 'LOGNAME': 'cltbld', 16:58:10 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:58:10 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:58:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:58:10 INFO - 'MOZ_NO_REMOTE': '1', 16:58:10 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:58:10 INFO - 'NO_EM_RESTART': '1', 16:58:10 INFO - 'PAGER': '/bin/cat', 16:58:10 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:58:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:58:10 INFO - 'PWD': '/builds/slave/test', 16:58:10 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:58:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:58:10 INFO - 'SHELL': '/bin/bash', 16:58:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9V5kUbaSaR/Listeners', 16:58:10 INFO - 'TMPDIR': '/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/', 16:58:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:58:10 INFO - 'USER': 'cltbld', 16:58:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:58:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:58:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:58:10 INFO - 'XPC_FLAGS': '0x0', 16:58:10 INFO - 'XPC_SERVICE_NAME': '0', 16:58:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:58:10 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/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0113', '--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 16:58:11 INFO - mozversion application_buildid: 20160401142339 16:58:11 INFO - mozversion application_changeset: 43f2fc45eaf759727dfed6893a8c2efc8c35ddf9 16:58:11 INFO - mozversion application_display_name: Nightly 16:58:11 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:58:11 INFO - mozversion application_name: Firefox 16:58:11 INFO - mozversion application_remotingname: firefox 16:58:11 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 16:58:11 INFO - mozversion application_vendor: Mozilla 16:58:11 INFO - mozversion application_version: 48.0a1 16:58:11 INFO - mozversion platform_buildid: 20160401142339 16:58:11 INFO - mozversion platform_changeset: 43f2fc45eaf759727dfed6893a8c2efc8c35ddf9 16:58:11 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 16:58:11 INFO - mozversion platform_version: 48.0a1 16:58:11 INFO - using testdate: 1459555091 16:58:11 INFO - actual date: 1459555091 16:58:11 INFO - starting webserver on 'localhost:49270' 16:58:11 INFO - SUITE-START | Running 2 tests 16:58:11 INFO - TEST-START | dromaeo_css 16:58:11 INFO - operating with platform_type : mac_ 16:58:11 INFO - Initialising browser for dromaeo_css test... 16:58:11 INFO - TEST-INFO | started process 1659 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmpXPyKXp/profile http://localhost:49270/getInfo.html) 16:58:13 INFO - PROCESS | 1659 | __metrics Screen width/height:1600/1200 16:58:13 INFO - PROCESS | 1659 | colorDepth:24 16:58:13 INFO - PROCESS | 1659 | Browser inner width/height: 1024/689 16:58:13 INFO - PROCESS | 1659 | __metrics 16:58:13 INFO - PROCESS | 1659 | 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" 16:58:13 ERROR - PROCESS | 1659 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 16:58:13 INFO - TEST-INFO | 1659: exit 0 16:58:13 INFO - Browser initialized. 16:58:13 INFO - Running cycle 1/1 for dromaeo_css test... 16:58:13 INFO - TEST-INFO | started process 1661 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmpXPyKXp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 16:58:25 INFO - PROCESS | 1661 | RSS: Main: 236642304 16:58:25 INFO - PROCESS | 1661 | 16:59:16 INFO - PROCESS | 1661 | 1459555156781 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] 17:01:27 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49270/tests/dromaeo/cssquery-ext.html) 17:01:28 INFO - PROCESS | 1661 | RSS: Main: 374378496 17:01:28 INFO - PROCESS | 1661 | 17:04:30 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-ext.html (next: http://localhost:49270/tests/dromaeo/cssquery-jquery.html) 17:04:31 INFO - PROCESS | 1661 | RSS: Main: 369336320 17:04:31 INFO - PROCESS | 1661 | 17:07:33 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49270/tests/dromaeo/cssquery-mootools.html) 17:07:34 INFO - PROCESS | 1661 | RSS: Main: 367820800 17:07:34 INFO - PROCESS | 1661 | 17:10:36 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49270/tests/dromaeo/cssquery-prototype.html) 17:10:36 INFO - PROCESS | 1661 | RSS: Main: 325066752 17:10:36 INFO - PROCESS | 1661 | 17:13:39 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49270/tests/dromaeo/cssquery-yui.html) 17:13:40 INFO - PROCESS | 1661 | RSS: Main: 328048640 17:13:40 INFO - PROCESS | 1661 | 17:16:43 INFO - PROCESS | 1661 | Cycle 1(1): loaded http://localhost:49270/tests/dromaeo/cssquery-yui.html (next: http://localhost:49270/tests/dromaeo/cssquery-dojo.html) 17:16:43 INFO - PROCESS | 1661 | RSS: Main: 372445184 17:16:43 INFO - PROCESS | 1661 | 17:16:43 INFO - PROCESS | 1661 | __start_tp_report 17:16:43 INFO - PROCESS | 1661 | _x_x_mozilla_page_load 17:16:43 INFO - PROCESS | 1661 | _x_x_mozilla_page_load_details 17:16:43 INFO - PROCESS | 1661 | |i|pagename|runs| 17:16:43 INFO - PROCESS | 1661 | |0;dojo.html;3004.2789730464688;3460.480927860819;3499.405101132807;3500.3874321993644;3526.118470382404;5623.409541998092;5686.488216060554;5721.456461636143;5754.65472071676;5808.01263785157;5697.145428185774;5706.971465142678;5774.884502309951;5839;5847.853803654911;5139.357580302462;5143.331366922304;5171.405288391827;5187.48125187482;5297.311349524556;5208.244804503344;5262.2632831403635;5301.7084060376665;5316.601254905898;5356.892862142755;5090.363704536933;5099.69401835891;5178.974105129488;5240.2401651760665;5252.501012403815;5194.506521880416;5203.661761985459;5209.958008398336;5217.58259339252;5256.789728410859;5144;5159.71621560814;5197.454267301917;5223.869403264911;5242.895142097137;5511.338639363302;5563.13771365435;5621.7751289948355;5630.09918413056;5689.374168841424;6232.376762323732;6257.749690012394;6262.248530176408;6265.592736472115;6278.340774218687;6264.436200741955;6304.148939893102;6306.65313407767;6323.9051414228825;6334.5249106317215;4882.926756098661;5686.545076393879;5777.220075289866;5782.10377391505;5794.652320860761;6252.874942501216;6268.091126786681;6271.372862713783;6274.466670332981;6293.181886354744;5514.724263786875;6068.302145253264;6098.786542471081;6105.419985101408;6144.477719393813;5168.431472538018;6129.570930034944;6169.105479705418;6281.842953926189;6281.8743625127245;6174.25908890936;6197.163382943335;6207.875842483125;6218.253809542884;6223.813285601349;6007.669578173242;6153.384661533811;6195.1636529068;6202.224721909762;6217.316095229521;4805.639577031667;4807.711537307773;4885.022995400934;4897.436794768576;4935.802567897315;4419.46966364032;4467.12890986261;4471.374007638933;4478.171538265431;4479.238529449936;5645.350784659735;5689.743961521742;5706.743196556165;5710.971445142748;5716.714164291769;6093.3836323348205;6114.114890844268;6130.826205142237;6144.9246381882995;6155.015197568458;5616.887662246732;5671.546276297886;5672.234248376499;5687.203791469197;5719.656820590694;4593.379893714306;5318.414974352818;5322.866928326745;5325.387580428301;5379.67721936685;6189.195404597373;6257.43683068526;6265.780697675559;6319.210098737658;6322.557420980487;6129.387061294014;6131.478824299985;6146.53900957439;6146.569740118149;6155.569110162425;6314.557980941474;6328.240611126695;6348.269948955929;6367.07677386767;6372.299047104722;5084.9745751271;6040.275166979991;6076.665783381956;6117.583689103346;6155.938440615537;6131.019036954066;6133.640713961282;6163.845903852261;6180.7527698891545;6194.0708893666315;5989.700514974146;6126.908096378647;6135.907961380493;6144.846378840565;6154.78458253959;6085.878282434415;6100.73256437228;6121.176758080412;6134.650895842834;6154.107654390178;4913.606911447004;5536.833894983157;5956.731947062479;6003.7898673546215;6023.367546407564;5987.760489580368;6083.908741368795;6131.908021379593;6135.877282454237;6146.985747351637;5941.821745347646;5962.19510366095;5966.075258334965;5979.1928089707335;6023.216981792339 17:16:43 INFO - PROCESS | 1661 | |1;ext.html;483.804059355961;573.1431509892711;577.1515871668646;639.852833848215;641.7304732012554;26680.86659566702;30790.768369265203;38491.422628660555;38731;38866.80566597163;42160;42360;42409.7879510602;42510;42552.57447425533;9423.528823558812;9675.080867317594;9679.854802177973;9684.90315096847;9690.982446843085;8063.798405039863;9454.101860323293;9613.51932403377;9643.662471813488;9644.614215431375;9554.378965367228;9686;9791.755206119868;9799;9823.754406139833;9694.321397502177;9758.707238782848;9777.511124443785;9783.90216097837;9803.509824508747;9501;9661.90338096617;9666.516674166263;9682.225421966295;9701.611935522571;40396.19207615861;40687;40798.59201408007;40817.77546673604;40851.57019504303;3183.80897146172;3251.707346338841;3289.901302960915;3751.2872554214614;3857.6528112470014;28431.715682843114;29062.27344316409;29281.414371712446;30061.549076763866;30095.849520752257;2766.405222877091;2781.415902660444;2830.2075418882746;2857.100013495742;2869;492610.53694731655;496238;497521;499415;501027;44948.77525612351;45385.773071134434;45444;63094.73810523764;63569.41076473125;44482.33276500855;44508.55491445044;44676.55323446724;44722.77638611786;44772.328415073796;15513.914026018296;15684.76472852908;15690.843091569166;15715.921420393053;15717.921410392875;12609.243445393306;12689.23864568129;12692.111552191443;12693.555725549562;12699.04757143218;14576;14629.92685036568;14645.194514301602;14661.92669036648;14738.852611473962;6093.482054025369;6229.719662615194;6247.625142491465;6252.499800015988;6259.812205633838;922.3128769067088;940.4498368454531;956.6508224498008;1043.7703705184847;1152.3777160333493;29090.854545727136;29150.979715709847;29697.96057138033;29790.10629681113;30085.849570752005;836.6987884361625;1005.2109094360892;1085.7122862441458;1087.6193332333619;1110.3171549497163;14698.853011469962;14712.55862324132;14790.556283311518;15109.697806043818;15191.848081519265;545895.5410445924;548311;548975;551102;552279;57096.429035709945;58352.416475834696;58427.123593146134;58430;58578.707106465044;1312.6718320419895;1315.9144655597547;1425.7932599772976;1455.1705527849235;1533.3789815125115;28908;29113;29370;29845.403091938475;30051.69948300489;47106.528934710215;47392.05215895732;47401.52598473971;47419;47562.524374757195;357068.214658925;368421;369086;369353;369766.3023369732;28330;32473.512897306086;32511.51232731558;32784.83607581947;33474;40734.777956661346;41271;42353;42788.1442371157;42799.78600107104;33019.504707428925;34785.30429391449;35163.472547912315;35315.646843531234;35423.29153416866;32207.677923220468;34149;34730;35442.46836297406;35472.64527354797;35028.299434011686;35550;36314.8184259077;36333.091672707335;36413.45379819252;29269.41461170722;31113.37773244568;31733;32045.839770800998;32104.83947580247;24017;24039;24364.147254846703;24568;24635 17:16:43 INFO - PROCESS | 1661 | |2;jquery.html;361.6961752128212;364.9616790237025;366.3113346907813;374.2365574228574;377.85263747138606;19574.412767616977;20132.496687582818;20484.590308193827;21385.67921481179;21394.786052139472;19127.61744765104;20647.483812904684;20919.790802091975;21020.8948955255;21029.263975760852;5625.099984002561;5928.199693041449;5974.731137098841;5975.342712301644;5979.910301345483;4974.726390048546;5563.276774019392;5811.476967072963;5818.941810581882;5820.185174075633;5739.339975902762;5798.739056742456;5802.506786923117;5816.302043754756;6121.66330851803;6052.152698622196;6057.697115144225;6090.543209259301;6091.451769340759;6092.147099406086;5539.8892022159735;5778.393268706809;5789.797357092523;5810.535157187457;5821.446962538552;13349.933250333783;13590.864091359059;13594.796078058836;13612.523561675393;20218.39344819643;1826.4246762269843;2078.7609424916177;2175.2495389090736;2663.613776002488;2700.338417087826;9585.616575336979;9771.022897710243;9955.25335599833;9991.800163996752;10118.392896426238;1712.3493072632446;1730.9307627694877;1737.4005967941166;1741.6342568060722;1760.269488162411;99934;104909;105524;108129;109452.4527377366;10559.313644613076;10589.788204235872;10708.787363790832;10944.945275273572;10963.780724385468;10754.892451075546;13015.869841301655;13016.674583135307;13020.739585208243;13045.804312935314;8276.006879174418;8464.365172611955;8488.151184881463;8565.229129378386;8570.100139485388;8660.523671198018;8676.826463470821;8688.609012594448;8781.121887811296;8786;4316.352547117895;4399.5160532341415;4441.267190913463;4450.5104438511735;4456.910861782746;1822.2528763207022;1865.8787178833331;1882.7834798998017;1894.3369820562693;1911.4838993471685;871.4205053639386;872.956816604152;932.5803388475214;960.500539719342;998.9150922171551;16186.75719864203;20399.694004589943;20636.79363206379;20828.895855520626;20872.895635521727;929.7210836749083;946.7301818981557;972.9075737804898;974.444566597047;995.4525011243787;7456.664450099758;9765.462899540451;11163.888361116286;11172.2124460086;11218.439078046065;597166;611641;612948;616952;637042;105648;106359;112064.51193860463;114568;115056.42471787588;910.3263584947091;988.4563490080427;995.1889210293588;1037.5071840875523;1037.657573000923;17721.468355949342;18038.5490362742;18136.365227217513;18168.27326906909;18279.543011424288;50111.74944125256;50247.49752502428;51767.44697658926;52032;52457.47542524526;70360.24099397556;72084;73236;75330;75364.62317688376;7344.412447004333;7466.626668666437;7775.883361749691;7804.6878124874365;7942.205779422012;9133.178013978773;9585.664501742405;11721.765564688489;12267.202631828903;12682.175658582162;10543.20925930543;10925.180611454332;11037.282576632493;11097.778044438905;11181.832272515756;7765.805854853674;10420.583176672848;10663.306885052447;10929.672109836718;11071.889281107407;7745.690172393041;7762.41781866351;7928.484648497829;8075.87886181696;8540.829183416172;10934.343939363664;11399;11657.825132622847;11765.235259708092;11766.882331176921;11339.943300283776;11425.31448113116;11708.47311870985;11761.529538818351;11916.582919597773 17:16:43 INFO - PROCESS | 1661 | |3;mootools.html;1401.0822910993304;1567.8824088193385;1580.2572790788329;1848.3807924345344;1996.8103030212126;7018.754343597975;8553.315734741222;8692.391532592721;8702.56487175641;8709.129087091287;8444.746657600283;8693;8704.216620504154;8710.564471776417;8720.781980450492;2173.152470536492;2187.223535644847;2358.9764102359013;2500.749925007503;2519.5590771614984;2482.7889629381525;2501.9249422517355;2502.649629051934;2508.297676650541;2508.8996440142373;2409.650600662903;2453.2149712092137;2470.147799009339;2471.864047477388;2472.629105634151;2379.48840999186;2391.402149462626;2404;2433.476802487474;2434.233216536803;2446.645236440724;2463.1994601754323;2464.494778570389;2480.06997375984;2487.6890388701413;8702.303815694793;8777.322916510462;8781.517016564087;8792.47245165292;8797.912020879838;5343.812966546191;5471.72641367934;5498.202760599691;5506.779728810843;5508.614396992212;3541.5218945442293;3635.836387362575;3720.2373513429684;3720.386136287509;3725.3666876631037;1010.13633343491;1012.5899010900597;1039.5270152080784;1050.3225419604312;1071.9035286824223;9448.574814133312;11790.823137652942;11833.230839995373;11837.230580012358;11845.407729613571;4792.257200133985;4827.324174615556;4858.80564777412;4906.460289368167;4921.188003979303;10055;10074.042965918226;10077.395356278646;10086.697399078039;10088.69733907984;5460.126379779216;5462.399136095027;5464.562834973192;5465.836024919259;5482.671039737628;4395.230834603995;4570.3829982951875;4823.807047718122;4881.755912204376;4949.7772600233075;3471.923703651876;3700.4634328022285;3901.843926242975;3914.373700207953;4005.018770401212;1129.305477131558;1325.3240847167822;1326.1446367093172;1339.2968691437075;1345.6501309659363;1350.014489422727;1369.88355989742;1370.184740079651;1371.3760239091189;1403.2282244765338;7947.562884041317;8137.959310203411;8156.83686326282;8214.1375155609;8222.547759873145;515.0908646239391;525.6662019617494;527.952484276417;531.3756336304826;533.3466503533218;6141.416565426277;6148.415900489446;6214.720337584819;6219;6221.782237621662;10264.589416423409;10624.309419887837;10629.734256643645;10674.679759607225;10684.679459616224;9958;10531.57873685044;10588.682339529827;10646.148308135485;10658.987396197348;8044.678212871419;8148.144444833326;8175.509469431853;8219.712310069119;8287.295579875657;7956.562389068657;7970;8004.119546849725;8038.477498962548;8183.181681831769;9103.954480227556;9373.859392108987;9395.577199026196;9440.575174117044;9482.857757133786;9470.337076404585;9630.518474076409;9733;9803.607855685692;10018.248631352531;6828;7018.368346848808;7196.10048743907;7460.776176714708;7560.810979725551;8151.592420378839;8155.959220203861;8196.262336389515;8210.425270231026;8220.83558328818;7260;7290.088738907637;7309.817254568678;7439.776806695808;7443.776686699408;7070.7525236616475;7152.105986751656;7156.069710937545;7185.82035449097;7235.63821808918;7587.848243035219;7700.614969251627;7700.768976930701;7721;7724.8455030900195;6888.207856096613;6897.3447522485285;6974.197967233833;6976.372126508639;6995.230524642387;7006.194287656985;7091.255418181223;7095.113110861143;7095.964520177573;7101.609411482418 17:16:43 INFO - PROCESS | 1661 | |4;prototype.html;321.6622546326357;323.39686484706016;328.7813603953371;330.92885029718605;331.66501833148527;6552.836179095525;6581.70382332795;6589.7364105435845;6595.241547222059;6605.86788264235;6542.542022058446;6574.638394888279;6576;6577.934220657792;6606.273309935903;4092.897677558055;4505.8422955196575;4748.97625511872;4750.596199323062;4892.021595680861;3887.241987812378;4822;4831.565159135677;4842.685225460334;4853.951460485403;4780;4792.353032340624;4795.640326975474;4799.13615549201;4804.207305794557;4583.472900616422;4673.4859165491935;4724.929126063112;4750.762461876892;4774.618030557547;4078.5105787305715;4085.1421201547414;4086.836526538935;4089.325261331877;4096.996235922218;6261.46777523911;6365.745370185187;6367;6367.395097465734;6397.8400539986405;5628.859278518029;5632.633878797865;5653.982283189024;5655.491005809456;5685.4883060524335;6702.6648667566915;6952.93047069533;6953.408960238386;6955.826104347381;6959.860802783916;4115.300398932159;4653.557911998355;4666.580007799281;4667.299905014241;4673.345731597579;6615.17310336208;6932.826679333007;7324.08448943882;7347.3020063094455;7427.331540161357;3852.4799152114665;4727.834525791581;4730.62155027597;4734.479207287196;4741.454732705714;4786.95213047872;4799.568038876448;4801.399825021872;4808.110499557593;4810;5654.74553645087;5659.830205093854;5667.659940403589;5670.177824215548;5689.288838895138;6805.566490827482;6925.549839260432;7033.8241543960785;7051.294870512907;7064;1647.6951763923473;1660.1533218058878;1669.4323929863904;1672.9832701673072;1676.5221911755334;984.9852252216223;1008.3949630221808;1034.1519953638094;1041.9166466682648;1078.5331948549965;6502.837429064217;6600.306967768412;6609.372109649576;6612.801615951529;6613.239477460057;7321.377682897013;7331.413486921034;7344.816379590553;7350.96324518374;7359.77920662381;6564.507661925375;6565.901511477332;6582.769603063965;6589.769358072444;6598.967005165039;3826.6989223664086;3867.0332416895776;3875.147467557133;3881.068543549528;3881.320768865494;7433.4053275737815;7670.117936437381;7680.807979800438;7699.422543309274;7699.461037727306;6657.667116644148;7006.264342244093;7569.810754731176;7573.35626471756;7585.355244804143;7643;7647.732329368557;7648.847023059397;7648.923510764933;7650.120236172911;7127.578762194072;7268.454865885185;7345.5959922202655;7354.8896766549615;7387.889181662387;7151.892721609076;7237.565746055254;7251.927480725125;7260.237675044044;7274;7631.122420921665;7635.923640763744;7648.158702542604;7656.234376562299;7664.885026724715;4547.136044151601;4597.908041839078;4603.286490593963;4606.6314694825005;4618.46887607916;6951.826204344729;7278.599677017814;7285;7298.087739032621;7306.634668266672;6128.233970753656;7067.505274630932;7102.076730025064;7106.182788979334;7121.252268511732;7035.366816986496;7060.682269297997;7065.894011589728;7082.18554866197;7084;6889.069975553236;6898.896516552356;6909.378155965987;6909.930900690929;6912.758053468105;5915.787263611035;6141.170941922784;6781.5591986522695;7062.964685176541;7072.611006394698;5467.507924286833;5991.011483105239;6216.502679785697;6809.080774095433;6902.723891044302 17:16:43 INFO - PROCESS | 1661 | |5;yui.html;747.7382915979406;765.3086579269079;768.9846203075939;775.1899265267795;777.7938846205755;15026.549203523899;15080.321385537649;15149.166795826226;15152.242387880617;15188.164650944194;11937.164398492108;13875.028747987644;13973.02188846781;13991.440342386319;14038.789418158736;733.3180142467503;743.0006641067755;746.0189850346777;746.1792028768366;894.4454438248296;886.4681191285242;907.9273658107369;920;923.6166990698852;926.1386910173536;969.6703120938879;983.921286297098;984.7931934293771;984.9655262065829;990.4750482244422;784.8077221080872;960.846264597661;964.8793900762405;966.0484422843493;967.9854802177973;684.8904175331973;717.921028686844;733.4205977277944;735.3051366458699;735.9521631093962;15164.772528411972;15252.23738813066;15292.158931258777;15314.081155130727;15317.693646127014;12650.620481385573;12662.11281008826;12684.809727853997;12726.681832954158;12849.935750321281;9927.751806204831;10026.298159128864;10098.89901100987;10398.584056637725;10732.788694202098;3578.248567800739;3650.452432135201;3655.670989610921;3687.8893633191046;3751.8499260029566;78874.60562697207;78965.60517197434;79588.99999999942;79609;79624.20375796226;9353.766155846159;9366.438013719198;9538.284628652878;9776.071273229032;10148.987210745414;18252.543686407946;22344.329670109924;22356.552868942854;22382.664260036112;22383.44041398978;7408.814779630445;7419.146798118178;7455.105387353552;7580.279873412017;7605;4072.511298644182;4105.096878686684;4139.751614903115;4152.833886644561;4177.561356057631;3471.756977011585;3479.6868281854754;3525.3125640499857;3529.6646818552194;3532.993096967352;657.8947368421029;659.7262136213418;663.0584569910739;673.0879658063352;674.9605607364604;567.2087438023933;576.4581293584017;608.0848323273533;613.1814028272217;620.9751609935643;7566.659500322388;7924.48490848093;8090.433669643068;8107.918920810835;8155.388345874083;553.9667619942736;590.6485641043658;605.5397502765882;616.1743264026227;621.2234706616729;3590.784552926833;3667.339878821838;3713.0717320669833;3731.3097077040834;3967.8412863485137;79058.41883162419;80078.5996070016;80498.19501804907;85549.57225213834;88375.67436488457;77507;78286;78505.60747196227;79246;81476.18523814804;55944.72027639917;68336.65831670909;70434.64782676156;70580.6470967642;71378.64310678413;7141.785746427616;7440.702371905063;7511.023566936482;7539.73610923637;7567.545947243183;38859.805700971316;51615.74192129015;51648;53350;53557.92884142373;51411.742941285054;69425.26436839119;69683.65158174177;70978.93531596927;72351.91472128028;11279.774404512027;11512.654620361403;11545.48045337945;11638.359890205782;11703.2978021319;11778.471527227815;11804.350760708243;11884.643460695846;11948.163628545919;12779.80830287565;9568.378055426376;10767.138628909512;10966.616168434066;11439.16574711966;12370.195937264049;9537.475438850652;10733.892661073289;11393.373404202277;11462.598809041643;11855.288682679067;11071.667849964513;11171.106311495223;11296.774064518499;11415.315081095161;11709.590164344207;8963.282937364866;9129.589168487566;9257.166854983085;9493.810123797624;9851.852222216816;8936.642534298555;8980;9483.66807161746;9641.710748677551;9662.323637345318 17:16:43 INFO - PROCESS | 1661 | __end_tp_report 17:16:43 INFO - PROCESS | 1661 | __start_cc_report 17:16:43 INFO - PROCESS | 1661 | _x_x_mozilla_cycle_collect,1266 17:16:43 INFO - PROCESS | 1661 | __end_cc_report 17:16:43 INFO - PROCESS | 1661 | __startTimestamp1459556203452__endTimestamp 17:16:43 INFO - PROCESS | 1661 | 17:16:43 INFO - PROCESS | 1661 | ------- Summary: start ------- 17:16:43 INFO - PROCESS | 1661 | Number of tests: 6 17:16:43 INFO - PROCESS | 1661 | 17:16:43 INFO - PROCESS | 1661 | [#0] dojo.html Cycles:165 Average:5701.29 Median:5962.20 stddev:641.38 (10.8%) stddev-sans-first:607.45 17:16:43 INFO - PROCESS | 1661 | Values: 3004.3 3460.5 3499.4 3500.4 3526.1 5623.4 5686.5 5721.5 5754.7 5808.0 5697.1 5707.0 5774.9 5839.0 5847.9 5139.4 5143.3 5171.4 5187.5 5297.3 5208.2 5262.3 5301.7 5316.6 5356.9 5090.4 5099.7 5179.0 5240.2 5252.5 5194.5 5203.7 5210.0 5217.6 5256.8 5144.0 5159.7 5197.5 5223.9 5242.9 5511.3 5563.1 5621.8 5630.1 5689.4 6232.4 6257.7 6262.2 6265.6 6278.3 6264.4 6304.1 6306.7 6323.9 6334.5 4882.9 5686.5 5777.2 5782.1 5794.7 6252.9 6268.1 6271.4 6274.5 6293.2 5514.7 6068.3 6098.8 6105.4 6144.5 5168.4 6129.6 6169.1 6281.8 6281.9 6174.3 6197.2 6207.9 6218.3 6223.8 6007.7 6153.4 6195.2 6202.2 6217.3 4805.6 4807.7 4885.0 4897.4 4935.8 4419.5 4467.1 4471.4 4478.2 4479.2 5645.4 5689.7 5706.7 5711.0 5716.7 6093.4 6114.1 6130.8 6144.9 6155.0 5616.9 5671.5 5672.2 5687.2 5719.7 4593.4 5318.4 5322.9 5325.4 5379.7 6189.2 6257.4 6265.8 6319.2 6322.6 6129.4 6131.5 6146.5 6146.6 6155.6 6314.6 6328.2 6348.3 6367.1 6372.3 5085.0 6040.3 6076.7 6117.6 6155.9 6131.0 6133.6 6163.8 6180.8 6194.1 5989.7 6126.9 6135.9 6144.8 6154.8 6085.9 6100.7 6121.2 6134.7 6154.1 4913.6 5536.8 5956.7 6003.8 6023.4 5987.8 6083.9 6131.9 6135.9 6147.0 5941.8 5962.2 5966.1 5979.2 6023.2 17:16:43 INFO - PROCESS | 1661 | 17:16:43 INFO - PROCESS | 1661 | [#1] ext.html Cycles:180 Average:60537.13 Median:186758.79 stddev:127159.63 (68.1%) stddev-sans-first:127436.41 17:16:43 INFO - PROCESS | 1661 | Values: 483.8 573.1 577.2 639.9 641.7 26680.9 30790.8 38491.4 38731.0 38866.8 42160.0 42360.0 42409.8 42510.0 42552.6 9423.5 9675.1 9679.9 9684.9 9691.0 8063.8 9454.1 9613.5 9643.7 9644.6 9554.4 9686.0 9791.8 9799.0 9823.8 9694.3 9758.7 9777.5 9783.9 9803.5 9501.0 9661.9 9666.5 9682.2 9701.6 40396.2 40687.0 40798.6 40817.8 40851.6 3183.8 3251.7 3289.9 3751.3 3857.7 28431.7 29062.3 29281.4 30061.5 30095.8 2766.4 2781.4 2830.2 2857.1 2869.0 492610.5 496238.0 497521.0 499415.0 501027.0 44948.8 45385.8 45444.0 63094.7 63569.4 44482.3 44508.6 44676.6 44722.8 44772.3 15513.9 15684.8 15690.8 15715.9 15717.9 12609.2 12689.2 12692.1 12693.6 12699.0 14576.0 14629.9 14645.2 14661.9 14738.9 6093.5 6229.7 6247.6 6252.5 6259.8 922.3 940.4 956.7 1043.8 1152.4 29090.9 29151.0 29698.0 29790.1 30085.8 836.7 1005.2 1085.7 1087.6 1110.3 14698.9 14712.6 14790.6 15109.7 15191.8 545895.5 548311.0 548975.0 551102.0 552279.0 57096.4 58352.4 58427.1 58430.0 58578.7 1312.7 1315.9 1425.8 1455.2 1533.4 28908.0 29113.0 29370.0 29845.4 30051.7 47106.5 47392.1 47401.5 47419.0 47562.5 357068.2 368421.0 369086.0 369353.0 369766.3 28330.0 32473.5 32511.5 32784.8 33474.0 40734.8 41271.0 42353.0 42788.1 42799.8 33019.5 34785.3 35163.5 35315.6 35423.3 32207.7 34149.0 34730.0 35442.5 35472.6 35028.3 35550.0 36314.8 36333.1 36413.5 29269.4 31113.4 31733.0 32045.8 32104.8 24017.0 24039.0 24364.1 24568.0 24635.0 17:16:43 INFO - PROCESS | 1661 | 17:16:43 INFO - PROCESS | 1661 | [#2] jquery.html Cycles:180 Average:34007.30 Median:376.04 stddev:101902.97 (27098.6%) stddev-sans-first:102157.52 17:16:43 INFO - PROCESS | 1661 | Values: 361.7 365.0 366.3 374.2 377.9 19574.4 20132.5 20484.6 21385.7 21394.8 19127.6 20647.5 20919.8 21020.9 21029.3 5625.1 5928.2 5974.7 5975.3 5979.9 4974.7 5563.3 5811.5 5818.9 5820.2 5739.3 5798.7 5802.5 5816.3 6121.7 6052.2 6057.7 6090.5 6091.5 6092.1 5539.9 5778.4 5789.8 5810.5 5821.4 13349.9 13590.9 13594.8 13612.5 20218.4 1826.4 2078.8 2175.2 2663.6 2700.3 9585.6 9771.0 9955.3 9991.8 10118.4 1712.3 1730.9 1737.4 1741.6 1760.3 99934.0 104909.0 105524.0 108129.0 109452.5 10559.3 10589.8 10708.8 10944.9 10963.8 10754.9 13015.9 13016.7 13020.7 13045.8 8276.0 8464.4 8488.2 8565.2 8570.1 8660.5 8676.8 8688.6 8781.1 8786.0 4316.4 4399.5 4441.3 4450.5 4456.9 1822.3 1865.9 1882.8 1894.3 1911.5 871.4 873.0 932.6 960.5 998.9 16186.8 20399.7 20636.8 20828.9 20872.9 929.7 946.7 972.9 974.4 995.5 7456.7 9765.5 11163.9 11172.2 11218.4 597166.0 611641.0 612948.0 616952.0 637042.0 105648.0 106359.0 112064.5 114568.0 115056.4 910.3 988.5 995.2 1037.5 1037.7 17721.5 18038.5 18136.4 18168.3 18279.5 50111.7 50247.5 51767.4 52032.0 52457.5 70360.2 72084.0 73236.0 75330.0 75364.6 7344.4 7466.6 7775.9 7804.7 7942.2 9133.2 9585.7 11721.8 12267.2 12682.2 10543.2 10925.2 11037.3 11097.8 11181.8 7765.8 10420.6 10663.3 10929.7 11071.9 7745.7 7762.4 7928.5 8075.9 8540.8 10934.3 11399.0 11657.8 11765.2 11766.9 11339.9 11425.3 11708.5 11761.5 11916.6 17:16:43 INFO - PROCESS | 1661 | 17:16:43 INFO - PROCESS | 1661 | [#3] mootools.html Cycles:180 Average:5987.67 Median:5461.26 stddev:3150.22 (57.7%) stddev-sans-first:3140.19 17:16:43 INFO - PROCESS | 1661 | Values: 1401.1 1567.9 1580.3 1848.4 1996.8 7018.8 8553.3 8692.4 8702.6 8709.1 8444.7 8693.0 8704.2 8710.6 8720.8 2173.2 2187.2 2359.0 2500.7 2519.6 2482.8 2501.9 2502.6 2508.3 2508.9 2409.7 2453.2 2470.1 2471.9 2472.6 2379.5 2391.4 2404.0 2433.5 2434.2 2446.6 2463.2 2464.5 2480.1 2487.7 8702.3 8777.3 8781.5 8792.5 8797.9 5343.8 5471.7 5498.2 5506.8 5508.6 3541.5 3635.8 3720.2 3720.4 3725.4 1010.1 1012.6 1039.5 1050.3 1071.9 9448.6 11790.8 11833.2 11837.2 11845.4 4792.3 4827.3 4858.8 4906.5 4921.2 10055.0 10074.0 10077.4 10086.7 10088.7 5460.1 5462.4 5464.6 5465.8 5482.7 4395.2 4570.4 4823.8 4881.8 4949.8 3471.9 3700.5 3901.8 3914.4 4005.0 1129.3 1325.3 1326.1 1339.3 1345.7 1350.0 1369.9 1370.2 1371.4 1403.2 7947.6 8138.0 8156.8 8214.1 8222.5 515.1 525.7 528.0 531.4 533.3 6141.4 6148.4 6214.7 6219.0 6221.8 10264.6 10624.3 10629.7 10674.7 10684.7 9958.0 10531.6 10588.7 10646.1 10659.0 8044.7 8148.1 8175.5 8219.7 8287.3 7956.6 7970.0 8004.1 8038.5 8183.2 9104.0 9373.9 9395.6 9440.6 9482.9 9470.3 9630.5 9733.0 9803.6 10018.2 6828.0 7018.4 7196.1 7460.8 7560.8 8151.6 8156.0 8196.3 8210.4 8220.8 7260.0 7290.1 7309.8 7439.8 7443.8 7070.8 7152.1 7156.1 7185.8 7235.6 7587.8 7700.6 7700.8 7721.0 7724.8 6888.2 6897.3 6974.2 6976.4 6995.2 7006.2 7091.3 7095.1 7096.0 7101.6 17:16:43 INFO - PROCESS | 1661 | 17:16:43 INFO - PROCESS | 1661 | [#4] prototype.html Cycles:180 Average:5730.30 Median:6575.32 stddev:1841.21 (28.0%) stddev-sans-first:1801.06 17:16:43 INFO - PROCESS | 1661 | Values: 321.7 323.4 328.8 330.9 331.7 6552.8 6581.7 6589.7 6595.2 6605.9 6542.5 6574.6 6576.0 6577.9 6606.3 4092.9 4505.8 4749.0 4750.6 4892.0 3887.2 4822.0 4831.6 4842.7 4854.0 4780.0 4792.4 4795.6 4799.1 4804.2 4583.5 4673.5 4724.9 4750.8 4774.6 4078.5 4085.1 4086.8 4089.3 4097.0 6261.5 6365.7 6367.0 6367.4 6397.8 5628.9 5632.6 5654.0 5655.5 5685.5 6702.7 6952.9 6953.4 6955.8 6959.9 4115.3 4653.6 4666.6 4667.3 4673.3 6615.2 6932.8 7324.1 7347.3 7427.3 3852.5 4727.8 4730.6 4734.5 4741.5 4787.0 4799.6 4801.4 4808.1 4810.0 5654.7 5659.8 5667.7 5670.2 5689.3 6805.6 6925.5 7033.8 7051.3 7064.0 1647.7 1660.2 1669.4 1673.0 1676.5 985.0 1008.4 1034.2 1041.9 1078.5 6502.8 6600.3 6609.4 6612.8 6613.2 7321.4 7331.4 7344.8 7351.0 7359.8 6564.5 6565.9 6582.8 6589.8 6599.0 3826.7 3867.0 3875.1 3881.1 3881.3 7433.4 7670.1 7680.8 7699.4 7699.5 6657.7 7006.3 7569.8 7573.4 7585.4 7643.0 7647.7 7648.8 7648.9 7650.1 7127.6 7268.5 7345.6 7354.9 7387.9 7151.9 7237.6 7251.9 7260.2 7274.0 7631.1 7635.9 7648.2 7656.2 7664.9 4547.1 4597.9 4603.3 4606.6 4618.5 6951.8 7278.6 7285.0 7298.1 7306.6 6128.2 7067.5 7102.1 7106.2 7121.3 7035.4 7060.7 7065.9 7082.2 7084.0 6889.1 6898.9 6909.4 6909.9 6912.8 5915.8 6141.2 6781.6 7063.0 7072.6 5467.5 5991.0 6216.5 6809.1 6902.7 17:16:43 INFO - PROCESS | 1661 | 17:16:43 INFO - PROCESS | 1661 | [#5] yui.html Cycles:180 Average:17875.98 Median:658.81 stddev:24800.98 (3764.5%) stddev-sans-first:24837.21 17:16:43 INFO - PROCESS | 1661 | Values: 747.7 765.3 769.0 775.2 777.8 15026.5 15080.3 15149.2 15152.2 15188.2 11937.2 13875.0 13973.0 13991.4 14038.8 733.3 743.0 746.0 746.2 894.4 886.5 907.9 920.0 923.6 926.1 969.7 983.9 984.8 985.0 990.5 784.8 960.8 964.9 966.0 968.0 684.9 717.9 733.4 735.3 736.0 15164.8 15252.2 15292.2 15314.1 15317.7 12650.6 12662.1 12684.8 12726.7 12849.9 9927.8 10026.3 10098.9 10398.6 10732.8 3578.2 3650.5 3655.7 3687.9 3751.8 78874.6 78965.6 79589.0 79609.0 79624.2 9353.8 9366.4 9538.3 9776.1 10149.0 18252.5 22344.3 22356.6 22382.7 22383.4 7408.8 7419.1 7455.1 7580.3 7605.0 4072.5 4105.1 4139.8 4152.8 4177.6 3471.8 3479.7 3525.3 3529.7 3533.0 657.9 659.7 663.1 673.1 675.0 567.2 576.5 608.1 613.2 621.0 7566.7 7924.5 8090.4 8107.9 8155.4 554.0 590.6 605.5 616.2 621.2 3590.8 3667.3 3713.1 3731.3 3967.8 79058.4 80078.6 80498.2 85549.6 88375.7 77507.0 78286.0 78505.6 79246.0 81476.2 55944.7 68336.7 70434.6 70580.6 71378.6 7141.8 7440.7 7511.0 7539.7 7567.5 38859.8 51615.7 51648.0 53350.0 53557.9 51411.7 69425.3 69683.7 70978.9 72351.9 11279.8 11512.7 11545.5 11638.4 11703.3 11778.5 11804.4 11884.6 11948.2 12779.8 9568.4 10767.1 10966.6 11439.2 12370.2 9537.5 10733.9 11393.4 11462.6 11855.3 11071.7 11171.1 11296.8 11415.3 11709.6 8963.3 9129.6 9257.2 9493.8 9851.9 8936.6 8980.0 9483.7 9641.7 9662.3 17:16:43 INFO - PROCESS | 1661 | -------- Summary: end -------- 17:16:43 INFO - PROCESS | 1661 | 17:16:44 INFO - TEST-INFO | 1661: exit 0 17:16:44 INFO - TEST-OK | dromaeo_css | took 1112964ms 17:16:44 INFO - TEST-START | kraken 17:16:44 INFO - operating with platform_type : mac_ 17:16:44 INFO - Initialising browser for kraken test... 17:16:44 INFO - TEST-INFO | started process 1671 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmp4r5eX7/profile http://localhost:49270/getInfo.html) 17:16:46 INFO - PROCESS | 1671 | __metrics Screen width/height:1600/1200 17:16:46 INFO - PROCESS | 1671 | colorDepth:24 17:16:46 INFO - PROCESS | 1671 | Browser inner width/height: 1024/689 17:16:46 INFO - PROCESS | 1671 | __metrics 17:16:46 INFO - PROCESS | 1671 | 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" 17:16:46 ERROR - PROCESS | 1671 | JavaScript error: resource://app/modules/AboutNewTab.jsm, line 36: TypeError: this.pageListener is null 17:16:46 INFO - TEST-INFO | 1671: exit 0 17:16:46 INFO - Browser initialized. 17:16:46 INFO - Running cycle 1/1 for kraken test... 17:16:46 INFO - TEST-INFO | started process 1673 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/T/tmp4r5eX7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 17:16:58 INFO - PROCESS | 1673 | RSS: Main: 236675072 17:16:58 INFO - PROCESS | 1673 | 17:17:01 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection) 17:17:01 INFO - PROCESS | 1673 | RSS: Main: 282664960 17:17:01 INFO - PROCESS | 1673 | 17:17:04 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-dft) 17:17:05 INFO - PROCESS | 1673 | RSS: Main: 292937728 17:17:05 INFO - PROCESS | 1673 | 17:17:08 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-fft) 17:17:09 INFO - PROCESS | 1673 | RSS: Main: 280469504 17:17:09 INFO - PROCESS | 1673 | 17:17:10 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator) 17:17:11 INFO - PROCESS | 1673 | RSS: Main: 283332608 17:17:11 INFO - PROCESS | 1673 | 17:17:13 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur) 17:17:14 INFO - PROCESS | 1673 | RSS: Main: 283549696 17:17:14 INFO - PROCESS | 1673 | 17:17:16 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom) 17:17:17 INFO - PROCESS | 1673 | RSS: Main: 283475968 17:17:17 INFO - PROCESS | 1673 | 17:17:20 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate) 17:17:21 INFO - PROCESS | 1673 | RSS: Main: 283807744 17:17:21 INFO - PROCESS | 1673 | 17:17:23 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial) 17:17:24 INFO - PROCESS | 1673 | RSS: Main: 283869184 17:17:24 INFO - PROCESS | 1673 | 17:17:26 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox) 17:17:26 INFO - PROCESS | 1673 | RSS: Main: 316145664 17:17:26 INFO - PROCESS | 1673 | 17:17:28 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes) 17:17:29 INFO - PROCESS | 1673 | RSS: Main: 316805120 17:17:29 INFO - PROCESS | 1673 | 17:17:31 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm) 17:17:31 INFO - PROCESS | 1673 | RSS: Main: 323182592 17:17:31 INFO - PROCESS | 1673 | 17:17:34 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 17:17:35 INFO - PROCESS | 1673 | RSS: Main: 324481024 17:17:35 INFO - PROCESS | 1673 | 17:17:37 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 17:17:38 INFO - PROCESS | 1673 | RSS: Main: 324898816 17:17:38 INFO - PROCESS | 1673 | 17:17:40 INFO - PROCESS | 1673 | Cycle 1(1): loaded http://localhost:49270/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49270/tests/kraken/driver.html?testName=ai-astar) 17:17:40 INFO - PROCESS | 1673 | RSS: Main: 387592192 17:17:40 INFO - PROCESS | 1673 | 17:17:40 INFO - PROCESS | 1673 | __start_tp_report 17:17:40 INFO - PROCESS | 1673 | _x_x_mozilla_page_load 17:17:40 INFO - PROCESS | 1673 | _x_x_mozilla_page_load_details 17:17:40 INFO - PROCESS | 1673 | |i|pagename|runs| 17:17:40 INFO - PROCESS | 1673 | |0;ai-astar;110;109;111;109;111;112;117;111;111;112 17:17:40 INFO - PROCESS | 1673 | |1;audio-beat-detection;156;127;140;166;114;130;158;148;169;126 17:17:40 INFO - PROCESS | 1673 | |2;audio-dft;186;184;185;182;184;184;185;179;181;182 17:17:40 INFO - PROCESS | 1673 | |3;audio-fft;75;73;83;80;57;57;58;80;78;56 17:17:40 INFO - PROCESS | 1673 | |4;audio-oscillator;94;91;129;77;80;81;116;80;81;118 17:17:40 INFO - PROCESS | 1673 | |5;imaging-gaussian-blur;87;84;88;84;87;83;89;85;87;84 17:17:40 INFO - PROCESS | 1673 | |6;imaging-darkroom;126;94;93;94;120;104;89;151;150;92 17:17:40 INFO - PROCESS | 1673 | |7;imaging-desaturate;86;85;85;85;86;86;85;85;84;84 17:17:40 INFO - PROCESS | 1673 | |8;json-parse-financial;53;55;53;53;52;52;54;62;52;50 17:17:40 INFO - PROCESS | 1673 | |9;json-stringify-tinderbox;62;69;70;77;68;70;68;67;66;67 17:17:40 INFO - PROCESS | 1673 | |10;stanford-crypto-aes;83;84;84;84;82;82;83;84;82;97 17:17:40 INFO - PROCESS | 1673 | |11;stanford-crypto-ccm;122;124;131;133;128;114;132;123;132;131 17:17:40 INFO - PROCESS | 1673 | |12;stanford-crypto-pbkdf2;136;129;140;139;141;127;162;176;171;139 17:17:40 INFO - PROCESS | 1673 | |13;stanford-crypto-sha256-iterative;67;70;82;95;77;67;66;68;67;67 17:17:40 INFO - PROCESS | 1673 | __end_tp_report 17:17:40 INFO - PROCESS | 1673 | __start_cc_report 17:17:40 INFO - PROCESS | 1673 | _x_x_mozilla_cycle_collect,1328 17:17:40 INFO - PROCESS | 1673 | __end_cc_report 17:17:40 INFO - PROCESS | 1673 | __startTimestamp1459556260256__endTimestamp 17:17:40 INFO - PROCESS | 1673 | 17:17:40 INFO - PROCESS | 1673 | ------- Summary: start ------- 17:17:40 INFO - PROCESS | 1673 | Number of tests: 14 17:17:40 INFO - PROCESS | 1673 | 17:17:40 INFO - PROCESS | 1673 | [#0] ai-astar Cycles:10 Average:111.30 Median:111.00 stddev:2.26 (2.0%) stddev-sans-first:2.35 17:17:40 INFO - PROCESS | 1673 | Values: 110.0 109.0 111.0 109.0 111.0 112.0 117.0 111.0 111.0 112.0 17:17:40 INFO - PROCESS | 1673 | 17:17:40 INFO - PROCESS | 1673 | [#1] audio-beat-detection Cycles:10 Average:143.40 Median:152.00 stddev:18.82 (12.4%) stddev-sans-first:19.40 17:17:40 INFO - PROCESS | 1673 | Values: 156.0 127.0 140.0 166.0 114.0 130.0 158.0 148.0 169.0 126.0 17:17:40 INFO - PROCESS | 1673 | 17:17:40 INFO - PROCESS | 1673 | [#2] audio-dft Cycles:10 Average:183.20 Median:184.00 stddev:2.15 (1.2%) stddev-sans-first:2.03 17:17:40 INFO - PROCESS | 1673 | Values: 186.0 184.0 185.0 182.0 184.0 184.0 185.0 179.0 181.0 182.0 17:17:40 INFO - PROCESS | 1673 | 17:17:40 INFO - PROCESS | 1673 | [#3] audio-fft Cycles:10 Average:69.70 Median:76.50 stddev:11.27 (14.7%) stddev-sans-first:11.79 17:17:40 INFO - PROCESS | 1673 | Values: 75.0 73.0 83.0 80.0 57.0 57.0 58.0 80.0 78.0 56.0 17:17:40 INFO - PROCESS | 1673 | 17:17:40 INFO - PROCESS | 1673 | [#4] audio-oscillator Cycles:10 Average:94.70 Median:80.50 stddev:19.17 (23.8%) stddev-sans-first:20.33 17:17:40 INFO - PROCESS | 1673 | Values: 94.0 91.0 129.0 77.0 80.0 81.0 116.0 80.0 81.0 118.0 17:17:40 INFO - PROCESS | 1673 | 17:17:40 INFO - PROCESS | 1673 | [#5] imaging-gaussian-blur Cycles:10 Average:85.80 Median:87.00 stddev:2.04 (2.3%) stddev-sans-first:2.12 17:17:40 INFO - PROCESS | 1673 | Values: 87.0 84.0 88.0 84.0 87.0 83.0 89.0 85.0 87.0 84.0 17:17:40 INFO - PROCESS | 1673 | 17:17:40 INFO - PROCESS | 1673 | [#6] imaging-darkroom Cycles:10 Average:111.30 Median:90.50 stddev:24.09 (26.6%) stddev-sans-first:24.95 17:17:40 INFO - PROCESS | 1673 | Values: 126.0 94.0 93.0 94.0 120.0 104.0 89.0 151.0 150.0 92.0 17:17:40 INFO - PROCESS | 1673 | 17:17:40 INFO - PROCESS | 1673 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:85.00 stddev:0.74 (0.9%) stddev-sans-first:0.71 17:17:40 INFO - PROCESS | 1673 | Values: 86.0 85.0 85.0 85.0 86.0 86.0 85.0 85.0 84.0 84.0 17:17:40 INFO - PROCESS | 1673 | 17:17:40 INFO - PROCESS | 1673 | [#8] json-parse-financial Cycles:10 Average:53.60 Median:53.00 stddev:3.24 (6.1%) stddev-sans-first:3.43 17:17:40 INFO - PROCESS | 1673 | Values: 53.0 55.0 53.0 53.0 52.0 52.0 54.0 62.0 52.0 50.0 17:17:40 INFO - PROCESS | 1673 | 17:17:40 INFO - PROCESS | 1673 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:3.81 (5.6%) stddev-sans-first:3.26 17:17:40 INFO - PROCESS | 1673 | Values: 62.0 69.0 70.0 77.0 68.0 70.0 68.0 67.0 66.0 67.0 17:17:40 INFO - PROCESS | 1673 | 17:17:40 INFO - PROCESS | 1673 | [#10] stanford-crypto-aes Cycles:10 Average:84.50 Median:84.00 stddev:4.48 (5.3%) stddev-sans-first:4.72 17:17:40 INFO - PROCESS | 1673 | Values: 83.0 84.0 84.0 84.0 82.0 82.0 83.0 84.0 82.0 97.0 17:17:40 INFO - PROCESS | 1673 | 17:17:40 INFO - PROCESS | 1673 | [#11] stanford-crypto-ccm Cycles:10 Average:127.00 Median:131.00 stddev:6.13 (4.7%) stddev-sans-first:6.23 17:17:40 INFO - PROCESS | 1673 | Values: 122.0 124.0 131.0 133.0 128.0 114.0 132.0 123.0 132.0 131.0 17:17:40 INFO - PROCESS | 1673 | 17:17:40 INFO - PROCESS | 1673 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.00 Median:140.50 stddev:17.29 (12.3%) stddev-sans-first:17.95 17:17:40 INFO - PROCESS | 1673 | Values: 136.0 129.0 140.0 139.0 141.0 127.0 162.0 176.0 171.0 139.0 17:17:40 INFO - PROCESS | 1673 | 17:17:40 INFO - PROCESS | 1673 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:72.60 Median:69.00 stddev:9.47 (13.7%) stddev-sans-first:9.82 17:17:40 INFO - PROCESS | 1673 | Values: 67.0 70.0 82.0 95.0 77.0 67.0 66.0 68.0 67.0 67.0 17:17:40 INFO - PROCESS | 1673 | -------- Summary: end -------- 17:17:40 INFO - PROCESS | 1673 | 17:17:40 INFO - TEST-INFO | 1673: exit 0 17:17:41 INFO - TEST-OK | kraken | took 56995ms 17:17:41 INFO - SUITE-END | took 1169s 17:17:41 INFO - Completed test suite (00:19:30) 17:17:41 INFO - javascript benchmark 17:17:41 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3004.2789730464688, 3460.480927860819, 3499.405101132807, 3500.3874321993644, 3526.118470382404, 5623.409541998092, 5686.488216060554, 5721.456461636143, 5754.65472071676, 5808.01263785157, 5697.145428185774, 5706.971465142678, 5774.884502309951, 5839.0, 5847.853803654911, 5139.357580302462, 5143.331366922304, 5171.405288391827, 5187.48125187482, 5297.311349524556, 5208.244804503344, 5262.2632831403635, 5301.7084060376665, 5316.601254905898, 5356.892862142755, 5090.363704536933, 5099.69401835891, 5178.974105129488, 5240.2401651760665, 5252.501012403815, 5194.506521880416, 5203.661761985459, 5209.958008398336, 5217.58259339252, 5256.789728410859, 5144.0, 5159.71621560814, 5197.454267301917, 5223.869403264911, 5242.895142097137, 5511.338639363302, 5563.13771365435, 5621.7751289948355, 5630.09918413056, 5689.374168841424, 6232.376762323732, 6257.749690012394, 6262.248530176408, 6265.592736472115, 6278.340774218687, 6264.436200741955, 6304.148939893102, 6306.65313407767, 6323.9051414228825, 6334.5249106317215, 4882.926756098661, 5686.545076393879, 5777.220075289866, 5782.10377391505, 5794.652320860761, 6252.874942501216, 6268.091126786681, 6271.372862713783, 6274.466670332981, 6293.181886354744, 5514.724263786875, 6068.302145253264, 6098.786542471081, 6105.419985101408, 6144.477719393813, 5168.431472538018, 6129.570930034944, 6169.105479705418, 6281.842953926189, 6281.8743625127245, 6174.25908890936, 6197.163382943335, 6207.875842483125, 6218.253809542884, 6223.813285601349, 6007.669578173242, 6153.384661533811, 6195.1636529068, 6202.224721909762, 6217.316095229521, 4805.639577031667, 4807.711537307773, 4885.022995400934, 4897.436794768576, 4935.802567897315, 4419.46966364032, 4467.12890986261, 4471.374007638933, 4478.171538265431, 4479.238529449936, 5645.350784659735, 5689.743961521742, 5706.743196556165, 5710.971445142748, 5716.714164291769, 6093.3836323348205, 6114.114890844268, 6130.826205142237, 6144.9246381882995, 6155.015197568458, 5616.887662246732, 5671.546276297886, 5672.234248376499, 5687.203791469197, 5719.656820590694, 4593.379893714306, 5318.414974352818, 5322.866928326745, 5325.387580428301, 5379.67721936685, 6189.195404597373, 6257.43683068526, 6265.780697675559, 6319.210098737658, 6322.557420980487, 6129.387061294014, 6131.478824299985, 6146.53900957439, 6146.569740118149, 6155.569110162425, 6314.557980941474, 6328.240611126695, 6348.269948955929, 6367.07677386767, 6372.299047104722, 5084.9745751271, 6040.275166979991, 6076.665783381956, 6117.583689103346, 6155.938440615537, 6131.019036954066, 6133.640713961282, 6163.845903852261, 6180.7527698891545, 6194.0708893666315, 5989.700514974146, 6126.908096378647, 6135.907961380493, 6144.846378840565, 6154.78458253959, 6085.878282434415, 6100.73256437228, 6121.176758080412, 6134.650895842834, 6154.107654390178, 4913.606911447004, 5536.833894983157, 5956.731947062479, 6003.7898673546215, 6023.367546407564, 5987.760489580368, 6083.908741368795, 6131.908021379593, 6135.877282454237, 6146.985747351637, 5941.821745347646, 5962.19510366095, 5966.075258334965, 5979.1928089707335, 6023.216981792339], "unit": "score", "name": "dojo.html", "value": 5661.7847275836175}, {"lowerIsBetter": false, "replicates": [483.804059355961, 573.1431509892711, 577.1515871668646, 639.852833848215, 641.7304732012554, 26680.86659566702, 30790.768369265203, 38491.422628660555, 38731.0, 38866.80566597163, 42160.0, 42360.0, 42409.7879510602, 42510.0, 42552.57447425533, 9423.528823558812, 9675.080867317594, 9679.854802177973, 9684.90315096847, 9690.982446843085, 8063.798405039863, 9454.101860323293, 9613.51932403377, 9643.662471813488, 9644.614215431375, 9554.378965367228, 9686.0, 9791.755206119868, 9799.0, 9823.754406139833, 9694.321397502177, 9758.707238782848, 9777.511124443785, 9783.90216097837, 9803.509824508747, 9501.0, 9661.90338096617, 9666.516674166263, 9682.225421966295, 9701.611935522571, 40396.19207615861, 40687.0, 40798.59201408007, 40817.77546673604, 40851.57019504303, 3183.80897146172, 3251.707346338841, 3289.901302960915, 3751.2872554214614, 3857.6528112470014, 28431.715682843114, 29062.27344316409, 29281.414371712446, 30061.549076763866, 30095.849520752257, 2766.405222877091, 2781.415902660444, 2830.2075418882746, 2857.100013495742, 2869.0, 492610.53694731655, 496238.0, 497521.0, 499415.0, 501027.0, 44948.77525612351, 45385.773071134434, 45444.0, 63094.73810523764, 63569.41076473125, 44482.33276500855, 44508.55491445044, 44676.55323446724, 44722.77638611786, 44772.328415073796, 15513.914026018296, 15684.76472852908, 15690.843091569166, 15715.921420393053, 15717.921410392875, 12609.243445393306, 12689.23864568129, 12692.111552191443, 12693.555725549562, 12699.04757143218, 14576.0, 14629.92685036568, 14645.194514301602, 14661.92669036648, 14738.852611473962, 6093.482054025369, 6229.719662615194, 6247.625142491465, 6252.499800015988, 6259.812205633838, 922.3128769067088, 940.4498368454531, 956.6508224498008, 1043.7703705184847, 1152.3777160333493, 29090.854545727136, 29150.979715709847, 29697.96057138033, 29790.10629681113, 30085.849570752005, 836.6987884361625, 1005.2109094360892, 1085.7122862441458, 1087.6193332333619, 1110.3171549497163, 14698.853011469962, 14712.55862324132, 14790.556283311518, 15109.697806043818, 15191.848081519265, 545895.5410445924, 548311.0, 548975.0, 551102.0, 552279.0, 57096.429035709945, 58352.416475834696, 58427.123593146134, 58430.0, 58578.707106465044, 1312.6718320419895, 1315.9144655597547, 1425.7932599772976, 1455.1705527849235, 1533.3789815125115, 28908.0, 29113.0, 29370.0, 29845.403091938475, 30051.69948300489, 47106.528934710215, 47392.05215895732, 47401.52598473971, 47419.0, 47562.524374757195, 357068.214658925, 368421.0, 369086.0, 369353.0, 369766.3023369732, 28330.0, 32473.512897306086, 32511.51232731558, 32784.83607581947, 33474.0, 40734.777956661346, 41271.0, 42353.0, 42788.1442371157, 42799.78600107104, 33019.504707428925, 34785.30429391449, 35163.472547912315, 35315.646843531234, 35423.29153416866, 32207.677923220468, 34149.0, 34730.0, 35442.46836297406, 35472.64527354797, 35028.299434011686, 35550.0, 36314.8184259077, 36333.091672707335, 36413.45379819252, 29269.41461170722, 31113.37773244568, 31733.0, 32045.839770800998, 32104.83947580247, 24017.0, 24039.0, 24364.147254846703, 24568.0, 24635.0], "unit": "score", "name": "ext.html", "value": 18836.84368084788}, {"lowerIsBetter": false, "replicates": [361.6961752128212, 364.9616790237025, 366.3113346907813, 374.2365574228574, 377.85263747138606, 19574.412767616977, 20132.496687582818, 20484.590308193827, 21385.67921481179, 21394.786052139472, 19127.61744765104, 20647.483812904684, 20919.790802091975, 21020.8948955255, 21029.263975760852, 5625.099984002561, 5928.199693041449, 5974.731137098841, 5975.342712301644, 5979.910301345483, 4974.726390048546, 5563.276774019392, 5811.476967072963, 5818.941810581882, 5820.185174075633, 5739.339975902762, 5798.739056742456, 5802.506786923117, 5816.302043754756, 6121.66330851803, 6052.152698622196, 6057.697115144225, 6090.543209259301, 6091.451769340759, 6092.147099406086, 5539.8892022159735, 5778.393268706809, 5789.797357092523, 5810.535157187457, 5821.446962538552, 13349.933250333783, 13590.864091359059, 13594.796078058836, 13612.523561675393, 20218.39344819643, 1826.4246762269843, 2078.7609424916177, 2175.2495389090736, 2663.613776002488, 2700.338417087826, 9585.616575336979, 9771.022897710243, 9955.25335599833, 9991.800163996752, 10118.392896426238, 1712.3493072632446, 1730.9307627694877, 1737.4005967941166, 1741.6342568060722, 1760.269488162411, 99934.0, 104909.0, 105524.0, 108129.0, 109452.4527377366, 10559.313644613076, 10589.788204235872, 10708.787363790832, 10944.945275273572, 10963.780724385468, 10754.892451075546, 13015.869841301655, 13016.674583135307, 13020.739585208243, 13045.804312935314, 8276.006879174418, 8464.365172611955, 8488.151184881463, 8565.229129378386, 8570.100139485388, 8660.523671198018, 8676.826463470821, 8688.609012594448, 8781.121887811296, 8786.0, 4316.352547117895, 4399.5160532341415, 4441.267190913463, 4450.5104438511735, 4456.910861782746, 1822.2528763207022, 1865.8787178833331, 1882.7834798998017, 1894.3369820562693, 1911.4838993471685, 871.4205053639386, 872.956816604152, 932.5803388475214, 960.500539719342, 998.9150922171551, 16186.75719864203, 20399.694004589943, 20636.79363206379, 20828.895855520626, 20872.895635521727, 929.7210836749083, 946.7301818981557, 972.9075737804898, 974.444566597047, 995.4525011243787, 7456.664450099758, 9765.462899540451, 11163.888361116286, 11172.2124460086, 11218.439078046065, 597166.0, 611641.0, 612948.0, 616952.0, 637042.0, 105648.0, 106359.0, 112064.51193860463, 114568.0, 115056.42471787588, 910.3263584947091, 988.4563490080427, 995.1889210293588, 1037.5071840875523, 1037.657573000923, 17721.468355949342, 18038.5490362742, 18136.365227217513, 18168.27326906909, 18279.543011424288, 50111.74944125256, 50247.49752502428, 51767.44697658926, 52032.0, 52457.47542524526, 70360.24099397556, 72084.0, 73236.0, 75330.0, 75364.62317688376, 7344.412447004333, 7466.626668666437, 7775.883361749691, 7804.6878124874365, 7942.205779422012, 9133.178013978773, 9585.664501742405, 11721.765564688489, 12267.202631828903, 12682.175658582162, 10543.20925930543, 10925.180611454332, 11037.282576632493, 11097.778044438905, 11181.832272515756, 7765.805854853674, 10420.583176672848, 10663.306885052447, 10929.672109836718, 11071.889281107407, 7745.690172393041, 7762.41781866351, 7928.484648497829, 8075.87886181696, 8540.829183416172, 10934.343939363664, 11399.0, 11657.825132622847, 11765.235259708092, 11766.882331176921, 11339.943300283776, 11425.31448113116, 11708.47311870985, 11761.529538818351, 11916.582919597773], "unit": "score", "name": "jquery.html", "value": 9176.510282947114}, {"lowerIsBetter": false, "replicates": [1401.0822910993304, 1567.8824088193385, 1580.2572790788329, 1848.3807924345344, 1996.8103030212126, 7018.754343597975, 8553.315734741222, 8692.391532592721, 8702.56487175641, 8709.129087091287, 8444.746657600283, 8693.0, 8704.216620504154, 8710.564471776417, 8720.781980450492, 2173.152470536492, 2187.223535644847, 2358.9764102359013, 2500.749925007503, 2519.5590771614984, 2482.7889629381525, 2501.9249422517355, 2502.649629051934, 2508.297676650541, 2508.8996440142373, 2409.650600662903, 2453.2149712092137, 2470.147799009339, 2471.864047477388, 2472.629105634151, 2379.48840999186, 2391.402149462626, 2404.0, 2433.476802487474, 2434.233216536803, 2446.645236440724, 2463.1994601754323, 2464.494778570389, 2480.06997375984, 2487.6890388701413, 8702.303815694793, 8777.322916510462, 8781.517016564087, 8792.47245165292, 8797.912020879838, 5343.812966546191, 5471.72641367934, 5498.202760599691, 5506.779728810843, 5508.614396992212, 3541.5218945442293, 3635.836387362575, 3720.2373513429684, 3720.386136287509, 3725.3666876631037, 1010.13633343491, 1012.5899010900597, 1039.5270152080784, 1050.3225419604312, 1071.9035286824223, 9448.574814133312, 11790.823137652942, 11833.230839995373, 11837.230580012358, 11845.407729613571, 4792.257200133985, 4827.324174615556, 4858.80564777412, 4906.460289368167, 4921.188003979303, 10055.0, 10074.042965918226, 10077.395356278646, 10086.697399078039, 10088.69733907984, 5460.126379779216, 5462.399136095027, 5464.562834973192, 5465.836024919259, 5482.671039737628, 4395.230834603995, 4570.3829982951875, 4823.807047718122, 4881.755912204376, 4949.7772600233075, 3471.923703651876, 3700.4634328022285, 3901.843926242975, 3914.373700207953, 4005.018770401212, 1129.305477131558, 1325.3240847167822, 1326.1446367093172, 1339.2968691437075, 1345.6501309659363, 1350.014489422727, 1369.88355989742, 1370.184740079651, 1371.3760239091189, 1403.2282244765338, 7947.562884041317, 8137.959310203411, 8156.83686326282, 8214.1375155609, 8222.547759873145, 515.0908646239391, 525.6662019617494, 527.952484276417, 531.3756336304826, 533.3466503533218, 6141.416565426277, 6148.415900489446, 6214.720337584819, 6219.0, 6221.782237621662, 10264.589416423409, 10624.309419887837, 10629.734256643645, 10674.679759607225, 10684.679459616224, 9958.0, 10531.57873685044, 10588.682339529827, 10646.148308135485, 10658.987396197348, 8044.678212871419, 8148.144444833326, 8175.509469431853, 8219.712310069119, 8287.295579875657, 7956.562389068657, 7970.0, 8004.119546849725, 8038.477498962548, 8183.181681831769, 9103.954480227556, 9373.859392108987, 9395.577199026196, 9440.575174117044, 9482.857757133786, 9470.337076404585, 9630.518474076409, 9733.0, 9803.607855685692, 10018.248631352531, 6828.0, 7018.368346848808, 7196.10048743907, 7460.776176714708, 7560.810979725551, 8151.592420378839, 8155.959220203861, 8196.262336389515, 8210.425270231026, 8220.83558328818, 7260.0, 7290.088738907637, 7309.817254568678, 7439.776806695808, 7443.776686699408, 7070.7525236616475, 7152.105986751656, 7156.069710937545, 7185.82035449097, 7235.63821808918, 7587.848243035219, 7700.614969251627, 7700.768976930701, 7721.0, 7724.8455030900195, 6888.207856096613, 6897.3447522485285, 6974.197967233833, 6976.372126508639, 6995.230524642387, 7006.194287656985, 7091.255418181223, 7095.113110861143, 7095.964520177573, 7101.609411482418], "unit": "score", "name": "mootools.html", "value": 4816.782380177756}, {"lowerIsBetter": false, "replicates": [321.6622546326357, 323.39686484706016, 328.7813603953371, 330.92885029718605, 331.66501833148527, 6552.836179095525, 6581.70382332795, 6589.7364105435845, 6595.241547222059, 6605.86788264235, 6542.542022058446, 6574.638394888279, 6576.0, 6577.934220657792, 6606.273309935903, 4092.897677558055, 4505.8422955196575, 4748.97625511872, 4750.596199323062, 4892.021595680861, 3887.241987812378, 4822.0, 4831.565159135677, 4842.685225460334, 4853.951460485403, 4780.0, 4792.353032340624, 4795.640326975474, 4799.13615549201, 4804.207305794557, 4583.472900616422, 4673.4859165491935, 4724.929126063112, 4750.762461876892, 4774.618030557547, 4078.5105787305715, 4085.1421201547414, 4086.836526538935, 4089.325261331877, 4096.996235922218, 6261.46777523911, 6365.745370185187, 6367.0, 6367.395097465734, 6397.8400539986405, 5628.859278518029, 5632.633878797865, 5653.982283189024, 5655.491005809456, 5685.4883060524335, 6702.6648667566915, 6952.93047069533, 6953.408960238386, 6955.826104347381, 6959.860802783916, 4115.300398932159, 4653.557911998355, 4666.580007799281, 4667.299905014241, 4673.345731597579, 6615.17310336208, 6932.826679333007, 7324.08448943882, 7347.3020063094455, 7427.331540161357, 3852.4799152114665, 4727.834525791581, 4730.62155027597, 4734.479207287196, 4741.454732705714, 4786.95213047872, 4799.568038876448, 4801.399825021872, 4808.110499557593, 4810.0, 5654.74553645087, 5659.830205093854, 5667.659940403589, 5670.177824215548, 5689.288838895138, 6805.566490827482, 6925.549839260432, 7033.8241543960785, 7051.294870512907, 7064.0, 1647.6951763923473, 1660.1533218058878, 1669.4323929863904, 1672.9832701673072, 1676.5221911755334, 984.9852252216223, 1008.3949630221808, 1034.1519953638094, 1041.9166466682648, 1078.5331948549965, 6502.837429064217, 6600.306967768412, 6609.372109649576, 6612.801615951529, 6613.239477460057, 7321.377682897013, 7331.413486921034, 7344.816379590553, 7350.96324518374, 7359.77920662381, 6564.507661925375, 6565.901511477332, 6582.769603063965, 6589.769358072444, 6598.967005165039, 3826.6989223664086, 3867.0332416895776, 3875.147467557133, 3881.068543549528, 3881.320768865494, 7433.4053275737815, 7670.117936437381, 7680.807979800438, 7699.422543309274, 7699.461037727306, 6657.667116644148, 7006.264342244093, 7569.810754731176, 7573.35626471756, 7585.355244804143, 7643.0, 7647.732329368557, 7648.847023059397, 7648.923510764933, 7650.120236172911, 7127.578762194072, 7268.454865885185, 7345.5959922202655, 7354.8896766549615, 7387.889181662387, 7151.892721609076, 7237.565746055254, 7251.927480725125, 7260.237675044044, 7274.0, 7631.122420921665, 7635.923640763744, 7648.158702542604, 7656.234376562299, 7664.885026724715, 4547.136044151601, 4597.908041839078, 4603.286490593963, 4606.6314694825005, 4618.46887607916, 6951.826204344729, 7278.599677017814, 7285.0, 7298.087739032621, 7306.634668266672, 6128.233970753656, 7067.505274630932, 7102.076730025064, 7106.182788979334, 7121.252268511732, 7035.366816986496, 7060.682269297997, 7065.894011589728, 7082.18554866197, 7084.0, 6889.069975553236, 6898.896516552356, 6909.378155965987, 6909.930900690929, 6912.758053468105, 5915.787263611035, 6141.170941922784, 6781.5591986522695, 7062.964685176541, 7072.611006394698, 5467.507924286833, 5991.011483105239, 6216.502679785697, 6809.080774095433, 6902.723891044302], "unit": "score", "name": "prototype.html", "value": 5113.589322813329}, {"lowerIsBetter": false, "replicates": [747.7382915979406, 765.3086579269079, 768.9846203075939, 775.1899265267795, 777.7938846205755, 15026.549203523899, 15080.321385537649, 15149.166795826226, 15152.242387880617, 15188.164650944194, 11937.164398492108, 13875.028747987644, 13973.02188846781, 13991.440342386319, 14038.789418158736, 733.3180142467503, 743.0006641067755, 746.0189850346777, 746.1792028768366, 894.4454438248296, 886.4681191285242, 907.9273658107369, 920.0, 923.6166990698852, 926.1386910173536, 969.6703120938879, 983.921286297098, 984.7931934293771, 984.9655262065829, 990.4750482244422, 784.8077221080872, 960.846264597661, 964.8793900762405, 966.0484422843493, 967.9854802177973, 684.8904175331973, 717.921028686844, 733.4205977277944, 735.3051366458699, 735.9521631093962, 15164.772528411972, 15252.23738813066, 15292.158931258777, 15314.081155130727, 15317.693646127014, 12650.620481385573, 12662.11281008826, 12684.809727853997, 12726.681832954158, 12849.935750321281, 9927.751806204831, 10026.298159128864, 10098.89901100987, 10398.584056637725, 10732.788694202098, 3578.248567800739, 3650.452432135201, 3655.670989610921, 3687.8893633191046, 3751.8499260029566, 78874.60562697207, 78965.60517197434, 79588.99999999942, 79609.0, 79624.20375796226, 9353.766155846159, 9366.438013719198, 9538.284628652878, 9776.071273229032, 10148.987210745414, 18252.543686407946, 22344.329670109924, 22356.552868942854, 22382.664260036112, 22383.44041398978, 7408.814779630445, 7419.146798118178, 7455.105387353552, 7580.279873412017, 7605.0, 4072.511298644182, 4105.096878686684, 4139.751614903115, 4152.833886644561, 4177.561356057631, 3471.756977011585, 3479.6868281854754, 3525.3125640499857, 3529.6646818552194, 3532.993096967352, 657.8947368421029, 659.7262136213418, 663.0584569910739, 673.0879658063352, 674.9605607364604, 567.2087438023933, 576.4581293584017, 608.0848323273533, 613.1814028272217, 620.9751609935643, 7566.659500322388, 7924.48490848093, 8090.433669643068, 8107.918920810835, 8155.388345874083, 553.9667619942736, 590.6485641043658, 605.5397502765882, 616.1743264026227, 621.2234706616729, 3590.784552926833, 3667.339878821838, 3713.0717320669833, 3731.3097077040834, 3967.8412863485137, 79058.41883162419, 80078.5996070016, 80498.19501804907, 85549.57225213834, 88375.67436488457, 77507.0, 78286.0, 78505.60747196227, 79246.0, 81476.18523814804, 55944.72027639917, 68336.65831670909, 70434.64782676156, 70580.6470967642, 71378.64310678413, 7141.785746427616, 7440.702371905063, 7511.023566936482, 7539.73610923637, 7567.545947243183, 38859.805700971316, 51615.74192129015, 51648.0, 53350.0, 53557.92884142373, 51411.742941285054, 69425.26436839119, 69683.65158174177, 70978.93531596927, 72351.91472128028, 11279.774404512027, 11512.654620361403, 11545.48045337945, 11638.359890205782, 11703.2978021319, 11778.471527227815, 11804.350760708243, 11884.643460695846, 11948.163628545919, 12779.80830287565, 9568.378055426376, 10767.138628909512, 10966.616168434066, 11439.16574711966, 12370.195937264049, 9537.475438850652, 10733.892661073289, 11393.373404202277, 11462.598809041643, 11855.288682679067, 11071.667849964513, 11171.106311495223, 11296.774064518499, 11415.315081095161, 11709.590164344207, 8963.282937364866, 9129.589168487566, 9257.166854983085, 9493.810123797624, 9851.852222216816, 8936.642534298555, 8980.0, 9483.66807161746, 9641.710748677551, 9662.323637345318], "unit": "score", "name": "yui.html", "value": 6852.225755483845}], "name": "dromaeo_css", "value": 7407.378868071876}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [110.0, 109.0, 111.0, 109.0, 111.0, 112.0, 117.0, 111.0, 111.0, 112.0], "unit": "score", "name": "ai-astar", "value": 111.3}, {"lowerIsBetter": true, "replicates": [156.0, 127.0, 140.0, 166.0, 114.0, 130.0, 158.0, 148.0, 169.0, 126.0], "unit": "score", "name": "audio-beat-detection", "value": 143.4}, {"lowerIsBetter": true, "replicates": [186.0, 184.0, 185.0, 182.0, 184.0, 184.0, 185.0, 179.0, 181.0, 182.0], "unit": "score", "name": "audio-dft", "value": 183.2}, {"lowerIsBetter": true, "replicates": [75.0, 73.0, 83.0, 80.0, 57.0, 57.0, 58.0, 80.0, 78.0, 56.0], "unit": "score", "name": "audio-fft", "value": 69.7}, {"lowerIsBetter": true, "replicates": [94.0, 91.0, 129.0, 77.0, 80.0, 81.0, 116.0, 80.0, 81.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 94.7}, {"lowerIsBetter": true, "replicates": [87.0, 84.0, 88.0, 84.0, 87.0, 83.0, 89.0, 85.0, 87.0, 84.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 85.8}, {"lowerIsBetter": true, "replicates": [126.0, 94.0, 93.0, 94.0, 120.0, 104.0, 89.0, 151.0, 150.0, 92.0], "unit": "score", "name": "imaging-darkroom", "value": 111.3}, {"lowerIsBetter": true, "replicates": [86.0, 85.0, 85.0, 85.0, 86.0, 86.0, 85.0, 85.0, 84.0, 84.0], "unit": "score", "name": "imaging-desaturate", "value": 85.1}, {"lowerIsBetter": true, "replicates": [53.0, 55.0, 53.0, 53.0, 52.0, 52.0, 54.0, 62.0, 52.0, 50.0], "unit": "score", "name": "json-parse-financial", "value": 53.6}, {"lowerIsBetter": true, "replicates": [62.0, 69.0, 70.0, 77.0, 68.0, 70.0, 68.0, 67.0, 66.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 84.0, 84.0, 82.0, 82.0, 83.0, 84.0, 82.0, 97.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.5}, {"lowerIsBetter": true, "replicates": [122.0, 124.0, 131.0, 133.0, 128.0, 114.0, 132.0, 123.0, 132.0, 131.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.0}, {"lowerIsBetter": true, "replicates": [136.0, 129.0, 140.0, 139.0, 141.0, 127.0, 162.0, 176.0, 171.0, 139.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.0}, {"lowerIsBetter": true, "replicates": [67.0, 70.0, 82.0, 95.0, 77.0, 67.0, 66.0, 68.0, 67.0, 67.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 72.6}], "name": "kraken", "value": 1436.6}]} 17:17:41 INFO - Return code: 0 17:17:41 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 17:17:41 ERROR - # TBPL SUCCESS # 17:17:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 17:17:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 17:17:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 17:17:41 INFO - 2016-04-01 17:17:41.571 screenresolution[1677:9936] starting screenresolution argv=screenresolution get 17:17:41 INFO - 2016-04-01 17:17:41.573 screenresolution[1677:9936] Display 0: 1600x1200x32@60 17:17:41 INFO - 2016-04-01 17:17:41.579 screenresolution[1678:9939] starting screenresolution argv=screenresolution list 17:17:41 INFO - Available Modes on Display 0 17:17:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 17:17:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 17:17:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 17:17:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 17:17:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 17:17:41 INFO - Intel Iris: 17:17:41 INFO - Chipset Model: Intel Iris 17:17:41 INFO - Type: GPU 17:17:41 INFO - Bus: Built-In 17:17:41 INFO - VRAM (Dynamic, Max): 1536 MB 17:17:41 INFO - Vendor: Intel (0x8086) 17:17:41 INFO - Device ID: 0x0a2e 17:17:41 INFO - Revision ID: 0x0009 17:17:41 INFO - Displays: 17:17:41 INFO - Display: 17:17:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 17:17:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 17:17:41 INFO - Display Serial Number: 1600x1200 60 17:17:41 INFO - Main Display: Yes 17:17:41 INFO - Mirror: Off 17:17:41 INFO - Online: Yes 17:17:41 INFO - Rotation: Supported 17:17:41 INFO - Return code: 0 17:17:41 INFO - Running post-action listener: _resource_record_post_action 17:17:41 INFO - Running post-run listener: _resource_record_post_run 17:17:42 INFO - Total resource usage - Wall time: 1206s; CPU: 53.0%; Read bytes: 37524992; Write bytes: 705496064; Read time: 433; Write time: 2000 17:17:42 INFO - install - Wall time: 34s; CPU: 54.0%; Read bytes: 400341504; Write bytes: 394499584; Read time: 29868; Write time: 746 17:17:42 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 35735040; Write bytes: 299843072; Read time: 414; Write time: 1220 17:17:42 INFO - Running post-run listener: _upload_blobber_files 17:17:42 INFO - Blob upload gear active. 17:17:42 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 17:17:42 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 17:17:42 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'] 17:17:42 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 17:17:44 INFO - (blobuploader) - INFO - Open directory for files ... 17:17:44 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 17:17:44 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:44 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:46 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 17:17:46 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:46 INFO - (blobuploader) - INFO - Done attempting. 17:17:46 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 17:17:46 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 17:17:46 INFO - (blobuploader) - INFO - Uploading, attempt #1. 17:17:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 17:17:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 17:17:49 INFO - (blobuploader) - INFO - Done attempting. 17:17:49 INFO - (blobuploader) - INFO - Iteration through files over. 17:17:49 INFO - Return code: 0 17:17:49 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 17:17:49 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 17:17:49 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ad15d0fe307edc4a94121c627fe1e7214f8c3039759de14c99a38f40d8b21dc4fc7b2723ca47184aa2e56cd61b01d45a243fc442c521beba3ed293c30f80014", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/037cc73d4740629fd02076cfecdec0eb698b77e75051c902581cbde62463d28d62a2dc9bd9f71fe7f64c5bc6ff79c2049fadc59e84f87eefd38c54306a722a78"} 17:17:49 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 17:17:49 INFO - Writing to file /builds/slave/test/properties/blobber_files 17:17:49 INFO - Contents: 17:17:49 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/2ad15d0fe307edc4a94121c627fe1e7214f8c3039759de14c99a38f40d8b21dc4fc7b2723ca47184aa2e56cd61b01d45a243fc442c521beba3ed293c30f80014", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/037cc73d4740629fd02076cfecdec0eb698b77e75051c902581cbde62463d28d62a2dc9bd9f71fe7f64c5bc6ff79c2049fadc59e84f87eefd38c54306a722a78"} 17:17:49 INFO - Running post-run listener: copy_logs_to_upload_dir 17:17:49 INFO - Copying logs to upload dir... 17:17:49 INFO - mkdir: /builds/slave/test/build/upload/logs 17:17:49 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1273.354809 ========= master_lag: 4.05 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-04-01 17:17:52.511323) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 17:17:52.515746) ========= 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.b4rQM18gMX/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.9V5kUbaSaR/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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/2ad15d0fe307edc4a94121c627fe1e7214f8c3039759de14c99a38f40d8b21dc4fc7b2723ca47184aa2e56cd61b01d45a243fc442c521beba3ed293c30f80014", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/037cc73d4740629fd02076cfecdec0eb698b77e75051c902581cbde62463d28d62a2dc9bd9f71fe7f64c5bc6ff79c2049fadc59e84f87eefd38c54306a722a78"} build_url:https://queue.taskcluster.net/v1/task/Jqzc4hZBRi-nmq27DXnoKA/artifacts/public/build/firefox-48.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011459 build_url: 'https://queue.taskcluster.net/v1/task/Jqzc4hZBRi-nmq27DXnoKA/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/2ad15d0fe307edc4a94121c627fe1e7214f8c3039759de14c99a38f40d8b21dc4fc7b2723ca47184aa2e56cd61b01d45a243fc442c521beba3ed293c30f80014", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/037cc73d4740629fd02076cfecdec0eb698b77e75051c902581cbde62463d28d62a2dc9bd9f71fe7f64c5bc6ff79c2049fadc59e84f87eefd38c54306a722a78"}' ========= master_lag: 0.05 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-04-01 17:17:52.582071) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 17:17:52.582403) ========= 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.b4rQM18gMX/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.9V5kUbaSaR/Listeners TMPDIR=/var/folders/1w/z0_4sknj0ws9ng8mf6fqh5bh00000w/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.005128 ========= master_lag: 0.44 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-04-01 17:17:53.022596) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 17:17:53.022903) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-04-01 17:17:53.025117) ========= ========= Total master_lag: 4.72 =========