builder: mozilla-aurora_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0150 starttime: 1457370532.67 results: success (0) buildid: 20160307063925 builduid: 633cace64bbb4bf493c844981d48214c revision: 8849dd1a4a796c2fd70d6f002912c3f799c59e69 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:52.669484) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:52.669898) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:52.670180) ========= 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.DyfHGqgQTw/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.41cBG8sqXz/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005469 basedir: '/builds/slave/test' ========= master_lag: 0.21 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:52.889404) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:52.889698) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:53.560326) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:53.560577) ========= 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.DyfHGqgQTw/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.41cBG8sqXz/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005723 ========= master_lag: 0.33 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:53.891752) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:53.892026) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:53.892363) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:53.892629) ========= 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.DyfHGqgQTw/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.41cBG8sqXz/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-03-07 09:08:53-- 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% 15.1M=0.001s 2016-03-07 09:08:54 (15.1 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.515234 ========= master_lag: 0.32 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:54.729635) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:54.729920) ========= 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.DyfHGqgQTw/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.41cBG8sqXz/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.026034 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:54.807809) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-07 09:08:54.808125) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8849dd1a4a796c2fd70d6f002912c3f799c59e69 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 8849dd1a4a796c2fd70d6f002912c3f799c59e69 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DyfHGqgQTw/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.41cBG8sqXz/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-03-07 09:08:55,052 truncating revision to first 12 chars 2016-03-07 09:08:55,052 Setting DEBUG logging. 2016-03-07 09:08:55,052 attempt 1/10 2016-03-07 09:08:55,052 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/8849dd1a4a79?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-03-07 09:08:56,056 unpacking tar archive at: mozilla-aurora-8849dd1a4a79/testing/mozharness/ program finished with exit code 0 elapsedTime=1.247535 ========= master_lag: 0.29 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-03-07 09:08:56.346264) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:56.346571) ========= echo 8849dd1a4a796c2fd70d6f002912c3f799c59e69 in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'8849dd1a4a796c2fd70d6f002912c3f799c59e69'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DyfHGqgQTw/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.41cBG8sqXz/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 8849dd1a4a796c2fd70d6f002912c3f799c59e69 program finished with exit code 0 elapsedTime=0.005686 script_repo_revision: '8849dd1a4a796c2fd70d6f002912c3f799c59e69' ========= master_lag: 0.96 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-03-07 09:08:57.315062) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2016-03-07 09:08:57.315352) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 3 secs) (at 2016-03-07 09:09:01.134740) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-03-07 09:09:01.135023) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Mozilla-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.DyfHGqgQTw/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.41cBG8sqXz/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:09:01 INFO - MultiFileLogger online at 20160307 09:09:01 in /builds/slave/test 09:09:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 09:09:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:09:01 INFO - {'append_to_log': False, 09:09:01 INFO - 'base_work_dir': '/builds/slave/test', 09:09:01 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 09:09:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:09:01 INFO - 'branch': 'Mozilla-Aurora', 09:09:01 INFO - 'buildbot_json_path': 'buildprops.json', 09:09:01 INFO - 'config_files': ('talos/mac_config.py',), 09:09:01 INFO - 'default_actions': ('clobber', 09:09:01 INFO - 'read-buildbot-config', 09:09:01 INFO - 'download-and-extract', 09:09:01 INFO - 'populate-webroot', 09:09:01 INFO - 'create-virtualenv', 09:09:01 INFO - 'install', 09:09:01 INFO - 'run-tests'), 09:09:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:09:01 INFO - 'download_minidump_stackwalk': True, 09:09:01 INFO - 'download_symbols': 'ondemand', 09:09:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:09:01 INFO - 'tooltool.py': '/tools/tooltool.py', 09:09:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:09:01 INFO - '/tools/misc-python/virtualenv.py')}, 09:09:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:09:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:09:01 INFO - 'installer_path': 'installer.exe', 09:09:01 INFO - 'log_level': 'info', 09:09:01 INFO - 'log_name': 'talos', 09:09:01 INFO - 'log_to_console': True, 09:09:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:09:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:09:01 INFO - 'opt_config_files': (), 09:09:01 INFO - 'pip_index': False, 09:09:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:09:01 INFO - 'cmd': ('bash', 09:09:01 INFO - '-c', 09:09:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:09:01 INFO - 'enabled': True, 09:09:01 INFO - 'halt_on_failure': False, 09:09:01 INFO - 'name': 'check_screen_resolution'},), 09:09:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:09:01 INFO - 'cmd': ('bash', 09:09:01 INFO - '-c', 09:09:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:09:01 INFO - 'enabled': True, 09:09:01 INFO - 'halt_on_failure': False, 09:09:01 INFO - 'name': 'check_screen_resolution'},), 09:09:01 INFO - 'run_cmd_checks_enabled': True, 09:09:01 INFO - 'sps_profile': False, 09:09:01 INFO - 'sps_profile_interval': 0, 09:09:01 INFO - 'suite': 'dromaeojs-e10s', 09:09:01 INFO - 'system_bits': '32', 09:09:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:09:01 INFO - 'title': 't-yosemite-r7-0150', 09:09:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:09:01 INFO - 'use_talos_json': True, 09:09:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:09:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:09:01 INFO - 'work_dir': 'build'} 09:09:01 INFO - ##### 09:09:01 INFO - ##### Running clobber step. 09:09:01 INFO - ##### 09:09:01 INFO - Running pre-action listener: _resource_record_pre_action 09:09:01 INFO - Running main action method: clobber 09:09:01 INFO - rmtree: /builds/slave/test/build 09:09:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:09:03 INFO - Running post-action listener: _resource_record_post_action 09:09:03 INFO - ##### 09:09:03 INFO - ##### Running read-buildbot-config step. 09:09:03 INFO - ##### 09:09:03 INFO - Running pre-action listener: _resource_record_pre_action 09:09:03 INFO - Running main action method: read_buildbot_config 09:09:03 INFO - Using buildbot properties: 09:09:03 INFO - { 09:09:03 INFO - "project": "", 09:09:03 INFO - "product": "firefox", 09:09:03 INFO - "script_repo_revision": "production", 09:09:03 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs-e10s", 09:09:03 INFO - "repository": "", 09:09:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs-e10s", 09:09:03 INFO - "buildid": "20160307063925", 09:09:03 INFO - "stage_platform": "macosx64", 09:09:03 INFO - "basedir": "/builds/slave/test", 09:09:03 INFO - "nightly_build": "True", 09:09:03 INFO - "buildnumber": 190, 09:09:03 INFO - "slavename": "t-yosemite-r7-0150", 09:09:03 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:09:03 INFO - "platform": "yosemite_r7", 09:09:03 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 09:09:03 INFO - "branch": "mozilla-aurora", 09:09:03 INFO - "repo_path": "releases/mozilla-aurora", 09:09:03 INFO - "revision": "8849dd1a4a796c2fd70d6f002912c3f799c59e69", 09:09:03 INFO - "pgo_build": "False", 09:09:03 INFO - "builduid": "633cace64bbb4bf493c844981d48214c", 09:09:03 INFO - "slavebuilddir": "test" 09:09:03 INFO - } 09:09:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg. 09:09:03 INFO - Running post-action listener: _resource_record_post_action 09:09:03 INFO - ##### 09:09:03 INFO - ##### Running download-and-extract step. 09:09:03 INFO - ##### 09:09:03 INFO - Running pre-action listener: _resource_record_pre_action 09:09:03 INFO - Running main action method: download_and_extract 09:09:03 INFO - mkdir: /builds/slave/test/build/tests 09:09: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')]} 09:09:03 INFO - https://queue.taskcluster.net/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json matches https://queue.taskcluster.net 09:09:03 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 09:09:03 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json 09:09:03 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 09:09:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json'}, attempt #1 09:09:12 INFO - Downloaded 1277 bytes. 09:09:12 INFO - Reading from file /builds/slave/test/build/firefox-47.0a2.en-US.mac.test_packages.json 09:09:12 INFO - Using the following test package requirements: 09:09:12 INFO - {u'common': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 09:09:12 INFO - u'cppunittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:09:12 INFO - u'firefox-47.0a2.en-US.mac.cppunittest.tests.zip'], 09:09:12 INFO - u'gtest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:09:12 INFO - u'firefox-47.0a2.en-US.mac.gtest.tests.zip'], 09:09:12 INFO - u'jittest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:09:12 INFO - u'jsshell-mac.zip'], 09:09:12 INFO - u'mochitest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:09:12 INFO - u'firefox-47.0a2.en-US.mac.mochitest.tests.zip'], 09:09:12 INFO - u'mozbase': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 09:09:12 INFO - u'reftest': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:09:12 INFO - u'firefox-47.0a2.en-US.mac.reftest.tests.zip'], 09:09:12 INFO - u'talos': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:09:12 INFO - u'firefox-47.0a2.en-US.mac.talos.tests.zip'], 09:09:12 INFO - u'web-platform': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:09:12 INFO - u'firefox-47.0a2.en-US.mac.web-platform.tests.zip'], 09:09:12 INFO - u'webapprt': [u'firefox-47.0a2.en-US.mac.common.tests.zip'], 09:09:12 INFO - u'xpcshell': [u'firefox-47.0a2.en-US.mac.common.tests.zip', 09:09:12 INFO - u'firefox-47.0a2.en-US.mac.xpcshell.tests.zip']} 09:09:12 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip'] for test suite category: common 09:09:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:12 INFO - https://queue.taskcluster.net/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:09:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:09:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:09:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:09:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:09:18 INFO - Downloaded 17864832 bytes. 09:09:18 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:09:18 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:09:21 INFO - Return code: 0 09:09:21 INFO - Downloading packages: [u'firefox-47.0a2.en-US.mac.common.tests.zip', u'firefox-47.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 09:09:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:21 INFO - https://queue.taskcluster.net/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:09:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:09:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:09:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip 09:09:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip'}, attempt #1 09:09:25 INFO - Downloaded 17864832 bytes. 09:09:25 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:09:25 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 09:09:28 INFO - Return code: 0 09:09:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:28 INFO - https://queue.taskcluster.net/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:09:28 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 09:09:28 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip 09:09:28 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip 09:09:28 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip'}, attempt #1 09:09:29 INFO - Downloaded 10845161 bytes. 09:09:29 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 09:09:29 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a2.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 09:09:29 INFO - Return code: 0 09:09: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')]} 09:09:29 INFO - https://queue.taskcluster.net/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg matches https://queue.taskcluster.net 09:09:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 09:09:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 09:09:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg 09:09:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg'}, attempt #1 09:09:32 INFO - Downloaded 115010584 bytes. 09:09:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 09:09:32 INFO - mkdir: /builds/slave/test/properties 09:09:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:09:32 INFO - Writing to file /builds/slave/test/properties/build_url 09:09:32 INFO - Contents: 09:09:32 INFO - build_url:https://queue.taskcluster.net/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg 09:09:33 INFO - Running post-action listener: _resource_record_post_action 09:09:33 INFO - Running post-action listener: set_extra_try_arguments 09:09:33 INFO - ##### 09:09:33 INFO - ##### Running populate-webroot step. 09:09:33 INFO - ##### 09:09:33 INFO - Running pre-action listener: _resource_record_pre_action 09:09:33 INFO - Running main action method: populate_webroot 09:09:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:09:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:09:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:09:33 INFO - '--tppagecycles', 09:09:33 INFO - '7'], 09:09:33 INFO - 'tests': ['tsvgm']}}, 09:09:33 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:09:33 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:09:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:09:33 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:09:33 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:09:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:09:33 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:09:33 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:33 INFO - 'talos_options': ['--e10s'], 09:09:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:09:33 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:33 INFO - 'tests': ['damp', 'tps']}, 09:09:33 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:33 INFO - 'talos_options': ['--e10s'], 09:09:33 INFO - 'tests': ['damp', 'tps']}, 09:09:33 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:09:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:09:33 INFO - 'other': {'tests': ['a11yr', 09:09:33 INFO - 'ts_paint', 09:09:33 INFO - 'tpaint', 09:09:33 INFO - 'sessionrestore', 09:09:33 INFO - 'sessionrestore_no_auto_restore', 09:09:33 INFO - 'tabpaint']}, 09:09:33 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:09:33 INFO - 'tests': ['a11yr', 09:09:33 INFO - 'ts_paint', 09:09:33 INFO - 'tpaint', 09:09:33 INFO - 'sessionrestore', 09:09:33 INFO - 'sessionrestore_no_auto_restore', 09:09:33 INFO - 'tabpaint']}, 09:09:33 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:09:33 INFO - 'tests': ['a11yr', 09:09:33 INFO - 'ts_paint', 09:09:33 INFO - 'tpaint', 09:09:33 INFO - 'sessionrestore', 09:09:33 INFO - 'sessionrestore_no_auto_restore', 09:09:33 INFO - 'tabpaint']}, 09:09:33 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:09:33 INFO - 'tests': ['a11yr', 09:09:33 INFO - 'ts_paint', 09:09:33 INFO - 'tpaint', 09:09:33 INFO - 'sessionrestore', 09:09:33 INFO - 'sessionrestore_no_auto_restore', 09:09:33 INFO - 'tabpaint']}, 09:09:33 INFO - 'other_l64': {'tests': ['a11yr', 09:09:33 INFO - 'ts_paint', 09:09:33 INFO - 'tpaint', 09:09:33 INFO - 'sessionrestore', 09:09:33 INFO - 'sessionrestore_no_auto_restore', 09:09:33 INFO - 'tabpaint']}, 09:09:33 INFO - 'other_nol64': {'tests': ['a11yr', 09:09:33 INFO - 'ts_paint', 09:09:33 INFO - 'tpaint', 09:09:33 INFO - 'sessionrestore', 09:09:33 INFO - 'sessionrestore_no_auto_restore', 09:09:33 INFO - 'tabpaint']}, 09:09:33 INFO - 'svgr': {'tests': ['tsvgx', 09:09:33 INFO - 'tsvgr_opacity', 09:09:33 INFO - 'tart', 09:09:33 INFO - 'tscrollx', 09:09:33 INFO - 'cart']}, 09:09:33 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:09:33 INFO - 'tests': ['tsvgx', 09:09:33 INFO - 'tsvgr_opacity', 09:09:33 INFO - 'tart', 09:09:33 INFO - 'tscrollx', 09:09:33 INFO - 'cart']}, 09:09:33 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:33 INFO - 'tests': ['tp5o']}, 09:09:33 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:33 INFO - 'talos_options': ['--e10s'], 09:09:33 INFO - 'tests': ['tp5o']}, 09:09:33 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:33 INFO - 'talos_options': ['--xperf_path', 09:09:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:09:33 INFO - 'tests': ['tp5n']}, 09:09:33 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:09:33 INFO - 'talos_options': ['--e10s', 09:09:33 INFO - '--xperf_path', 09:09:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:09:33 INFO - 'tests': ['tp5n']}}, 09:09:33 INFO - 'talos.zip': {'path': '', 09:09:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:09:33 INFO - Running post-action listener: _resource_record_post_action 09:09:33 INFO - ##### 09:09:33 INFO - ##### Running create-virtualenv step. 09:09:33 INFO - ##### 09:09:33 INFO - Running pre-action listener: _resource_record_pre_action 09:09:33 INFO - Running main action method: create_virtualenv 09:09:33 INFO - Creating virtualenv /builds/slave/test/build/venv 09:09:33 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:09:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:09:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:09:33 INFO - Using real prefix '/tools/python27' 09:09:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:09:34 INFO - Installing distribute.............................................................................................................................................................................................done. 09:09:37 INFO - Installing pip.................done. 09:09:37 INFO - Return code: 0 09:09:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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')]} 09:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f27ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa48d95130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f122d30>, '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 0x10ef86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f119b20>, '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.DyfHGqgQTw/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.41cBG8sqXz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:09:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:09:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DyfHGqgQTw/Render', 09:09:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:37 INFO - 'HOME': '/Users/cltbld', 09:09:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:37 INFO - 'LOGNAME': 'cltbld', 09:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:37 INFO - 'MOZ_NO_REMOTE': '1', 09:09:37 INFO - 'NO_EM_RESTART': '1', 09:09:37 INFO - 'PAGER': '/bin/cat', 09:09:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:37 INFO - 'PWD': '/builds/slave/test', 09:09:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:37 INFO - 'SHELL': '/bin/bash', 09:09:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41cBG8sqXz/Listeners', 09:09:37 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:09:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:37 INFO - 'USER': 'cltbld', 09:09:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:37 INFO - 'XPC_FLAGS': '0x0', 09:09:37 INFO - 'XPC_SERVICE_NAME': '0', 09:09:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:09:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:37 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:09:37 INFO - Cleaning up... 09:09:37 INFO - Return code: 0 09:09:37 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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')]} 09:09:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f27ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa48d95130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f122d30>, '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 0x10ef86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f119b20>, '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.DyfHGqgQTw/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.41cBG8sqXz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:09:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:09:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:09:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DyfHGqgQTw/Render', 09:09:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:37 INFO - 'HOME': '/Users/cltbld', 09:09:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:37 INFO - 'LOGNAME': 'cltbld', 09:09:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:37 INFO - 'MOZ_NO_REMOTE': '1', 09:09:37 INFO - 'NO_EM_RESTART': '1', 09:09:37 INFO - 'PAGER': '/bin/cat', 09:09:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:37 INFO - 'PWD': '/builds/slave/test', 09:09:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:37 INFO - 'SHELL': '/bin/bash', 09:09:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41cBG8sqXz/Listeners', 09:09:37 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:09:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:37 INFO - 'USER': 'cltbld', 09:09:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:37 INFO - 'XPC_FLAGS': '0x0', 09:09:37 INFO - 'XPC_SERVICE_NAME': '0', 09:09:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:09:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:38 INFO - Downloading/unpacking psutil>=0.7.1 09:09:38 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 09:09:38 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 09:09:38 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 09:09:38 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 09:09:38 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 09:09:38 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 09:09:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:09:41 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:09:41 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:09:41 INFO - Installing collected packages: psutil 09:09:41 INFO - Running setup.py install for psutil 09:09:41 INFO - building 'psutil._psutil_osx' extension 09:09:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:09:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:09:42 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 09:09:42 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 09:09:42 INFO - building 'psutil._psutil_posix' extension 09:09:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:09:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:09:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:09:42 INFO - ^ 09:09:42 INFO - 1 warning generated. 09:09:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:09:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:09:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:09:42 INFO - Successfully installed psutil 09:09:42 INFO - Cleaning up... 09:09:42 INFO - Return code: 0 09:09:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f27ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa48d95130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f122d30>, '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 0x10ef86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f119b20>, '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.DyfHGqgQTw/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.41cBG8sqXz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:09:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:09:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:09:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DyfHGqgQTw/Render', 09:09:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:42 INFO - 'HOME': '/Users/cltbld', 09:09:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:42 INFO - 'LOGNAME': 'cltbld', 09:09:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:42 INFO - 'MOZ_NO_REMOTE': '1', 09:09:42 INFO - 'NO_EM_RESTART': '1', 09:09:42 INFO - 'PAGER': '/bin/cat', 09:09:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:42 INFO - 'PWD': '/builds/slave/test', 09:09:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:42 INFO - 'SHELL': '/bin/bash', 09:09:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41cBG8sqXz/Listeners', 09:09:42 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:09:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:42 INFO - 'USER': 'cltbld', 09:09:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:42 INFO - 'XPC_FLAGS': '0x0', 09:09:42 INFO - 'XPC_SERVICE_NAME': '0', 09:09:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:09:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:09:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:09:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:09:45 INFO - Installing collected packages: mozsystemmonitor 09:09:45 INFO - Running setup.py install for mozsystemmonitor 09:09:45 INFO - Successfully installed mozsystemmonitor 09:09:45 INFO - Cleaning up... 09:09:45 INFO - Return code: 0 09:09:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:45 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f27ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa48d95130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f122d30>, '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 0x10ef86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f119b20>, '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.DyfHGqgQTw/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.41cBG8sqXz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:09:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:09:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:09:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DyfHGqgQTw/Render', 09:09:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:45 INFO - 'HOME': '/Users/cltbld', 09:09:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:45 INFO - 'LOGNAME': 'cltbld', 09:09:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:45 INFO - 'MOZ_NO_REMOTE': '1', 09:09:45 INFO - 'NO_EM_RESTART': '1', 09:09:45 INFO - 'PAGER': '/bin/cat', 09:09:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:45 INFO - 'PWD': '/builds/slave/test', 09:09:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:45 INFO - 'SHELL': '/bin/bash', 09:09:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41cBG8sqXz/Listeners', 09:09:45 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:09:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:45 INFO - 'USER': 'cltbld', 09:09:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:45 INFO - 'XPC_FLAGS': '0x0', 09:09:45 INFO - 'XPC_SERVICE_NAME': '0', 09:09:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:09:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:45 INFO - Downloading/unpacking blobuploader==1.2.4 09:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:47 INFO - Downloading blobuploader-1.2.4.tar.gz 09:09:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:09:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:09:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:49 INFO - Downloading docopt-0.6.1.tar.gz 09:09:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:09:49 INFO - Installing collected packages: blobuploader, requests, docopt 09:09:49 INFO - Running setup.py install for blobuploader 09:09:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:09:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:09:49 INFO - Running setup.py install for requests 09:09:49 INFO - Running setup.py install for docopt 09:09:49 INFO - Successfully installed blobuploader requests docopt 09:09:49 INFO - Cleaning up... 09:09:50 INFO - Return code: 0 09:09:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:50 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')]} 09:09:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:50 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')]} 09:09:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:50 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 0x10f27ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa48d95130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f122d30>, '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 0x10ef86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f119b20>, '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.DyfHGqgQTw/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.41cBG8sqXz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:09:50 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 09:09:50 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 09:09:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DyfHGqgQTw/Render', 09:09:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:50 INFO - 'HOME': '/Users/cltbld', 09:09:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:50 INFO - 'LOGNAME': 'cltbld', 09:09:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:50 INFO - 'MOZ_NO_REMOTE': '1', 09:09:50 INFO - 'NO_EM_RESTART': '1', 09:09:50 INFO - 'PAGER': '/bin/cat', 09:09:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:50 INFO - 'PWD': '/builds/slave/test', 09:09:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:50 INFO - 'SHELL': '/bin/bash', 09:09:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41cBG8sqXz/Listeners', 09:09:50 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:09:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:50 INFO - 'USER': 'cltbld', 09:09:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:50 INFO - 'XPC_FLAGS': '0x0', 09:09:50 INFO - 'XPC_SERVICE_NAME': '0', 09:09:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:09:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:50 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-08TPIW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:50 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-5CaLwL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:50 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-7FzdyA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:50 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-6EEpc1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:50 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-L7onhS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:50 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-5JpP61-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:50 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-b7wwqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-4B7YHX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-quJx9j-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-8m8i30-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-vCABnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-fcm3GX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-u80GVj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-udjSiu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-HOqnop-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-92orBi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:51 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-kQ0P7Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:09:52 INFO - Running setup.py install for manifestparser 09:09:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:09:52 INFO - Running setup.py install for mozcrash 09:09:52 INFO - Running setup.py install for mozdebug 09:09:52 INFO - Running setup.py install for mozdevice 09:09:52 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:09:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:09:52 INFO - Running setup.py install for mozfile 09:09:52 INFO - Running setup.py install for mozhttpd 09:09:52 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:09:52 INFO - Running setup.py install for mozinfo 09:09:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:09:53 INFO - Running setup.py install for mozInstall 09:09:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:09:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:09:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:09:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:09:53 INFO - Running setup.py install for mozleak 09:09:53 INFO - Running setup.py install for mozlog 09:09:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:09:53 INFO - Running setup.py install for moznetwork 09:09:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:09:53 INFO - Running setup.py install for mozprocess 09:09:53 INFO - Running setup.py install for mozprofile 09:09:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:09:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:09:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:09:54 INFO - Running setup.py install for mozrunner 09:09:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:09:54 INFO - Running setup.py install for mozscreenshot 09:09:54 INFO - Running setup.py install for moztest 09:09:54 INFO - Running setup.py install for mozversion 09:09:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:09:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:09:54 INFO - Cleaning up... 09:09:54 INFO - Return code: 0 09:09:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09: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')]} 09:09:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09: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')]} 09:09:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:54 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f27ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa48d95130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f122d30>, '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 0x10ef86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f119b20>, '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.DyfHGqgQTw/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.41cBG8sqXz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:09:54 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:09:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:09:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DyfHGqgQTw/Render', 09:09:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:54 INFO - 'HOME': '/Users/cltbld', 09:09:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:54 INFO - 'LOGNAME': 'cltbld', 09:09:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:54 INFO - 'MOZ_NO_REMOTE': '1', 09:09:54 INFO - 'NO_EM_RESTART': '1', 09:09:54 INFO - 'PAGER': '/bin/cat', 09:09:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:54 INFO - 'PWD': '/builds/slave/test', 09:09:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:54 INFO - 'SHELL': '/bin/bash', 09:09:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41cBG8sqXz/Listeners', 09:09:54 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:09:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:54 INFO - 'USER': 'cltbld', 09:09:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:54 INFO - 'XPC_FLAGS': '0x0', 09:09:54 INFO - 'XPC_SERVICE_NAME': '0', 09:09:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:09:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:54 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:09:54 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-yOTxaa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:09:55 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)) 09:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:09:55 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-cfhtbX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:09:55 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)) 09:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:09:55 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-OVJ4rX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:09:55 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)) 09:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:09:55 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-D6BSSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:09:55 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-SRhEh9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:09:55 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Il3w0n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:09:55 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-BW_HTz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:09:55 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-ASYWUP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:09:55 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-bUZNas-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:09:55 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-6Q3dwj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:09:55 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:09:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:09:55 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-S9puqs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:09:56 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)) 09:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:09:56 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-m70zWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:09:56 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)) 09:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:09:56 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-NI654t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:09:56 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-5JvnLc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:56 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-Mg7B1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:09:56 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-BetZhT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:09:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:09:56 INFO - Running setup.py (path:/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/pip-8cZfaE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 09:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:09:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:09:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:09:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:09:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:09:59 INFO - Downloading blessings-1.6.tar.gz 09:09:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:09:59 INFO - Installing collected packages: blessings 09:09:59 INFO - Running setup.py install for blessings 09:09:59 INFO - Successfully installed blessings 09:09:59 INFO - Cleaning up... 09:09:59 INFO - Return code: 0 09:09:59 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:09:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:09:59 INFO - Reading from file tmpfile_stdout 09:09:59 INFO - Current package versions: 09:09:59 INFO - blessings == 1.6 09:09:59 INFO - blobuploader == 1.2.4 09:09:59 INFO - docopt == 0.6.1 09:09:59 INFO - manifestparser == 1.1 09:09:59 INFO - mozInstall == 1.12 09:09:59 INFO - mozcrash == 0.17 09:09:59 INFO - mozdebug == 0.1 09:09:59 INFO - mozdevice == 0.48 09:09:59 INFO - mozfile == 1.2 09:09:59 INFO - mozhttpd == 0.7 09:09:59 INFO - mozinfo == 0.9 09:09:59 INFO - mozleak == 0.1 09:09:59 INFO - mozlog == 3.1 09:09:59 INFO - moznetwork == 0.27 09:09:59 INFO - mozprocess == 0.22 09:09:59 INFO - mozprofile == 0.28 09:09:59 INFO - mozrunner == 6.11 09:09:59 INFO - mozscreenshot == 0.1 09:09:59 INFO - mozsystemmonitor == 0.0 09:09:59 INFO - moztest == 0.7 09:09:59 INFO - mozversion == 1.4 09:09:59 INFO - psutil == 3.1.1 09:09:59 INFO - requests == 1.2.3 09:09:59 INFO - wsgiref == 0.1.2 09:09:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:09:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:09:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:09:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:09:59 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f27ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa48d95130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f122d30>, '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 0x10ef86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f119b20>, '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.DyfHGqgQTw/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.41cBG8sqXz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:09:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:09:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:09:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DyfHGqgQTw/Render', 09:09:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:09:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:09:59 INFO - 'HOME': '/Users/cltbld', 09:09:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:09:59 INFO - 'LOGNAME': 'cltbld', 09:09:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:09:59 INFO - 'MOZ_NO_REMOTE': '1', 09:09:59 INFO - 'NO_EM_RESTART': '1', 09:09:59 INFO - 'PAGER': '/bin/cat', 09:09:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:09:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:09:59 INFO - 'PWD': '/builds/slave/test', 09:09:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:09:59 INFO - 'SHELL': '/bin/bash', 09:09:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41cBG8sqXz/Listeners', 09:09:59 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:09:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:09:59 INFO - 'USER': 'cltbld', 09:09:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:09:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:09:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:09:59 INFO - 'XPC_FLAGS': '0x0', 09:09:59 INFO - 'XPC_SERVICE_NAME': '0', 09:09:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:09:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:09:59 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)) 09:09:59 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)) 09:09:59 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)) 09:09:59 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)) 09:09:59 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)) 09:09:59 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)) 09:09:59 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)) 09:09:59 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)) 09:09:59 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)) 09:09:59 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)) 09:09:59 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)) 09:09:59 INFO - Cleaning up... 09:10:00 INFO - Return code: 0 09:10:00 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:10:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:00 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f27ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa48d95130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f122d30>, '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 0x10ef86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f119b20>, '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.DyfHGqgQTw/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.41cBG8sqXz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:10:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:10:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:10:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DyfHGqgQTw/Render', 09:10:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:00 INFO - 'HOME': '/Users/cltbld', 09:10:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:00 INFO - 'LOGNAME': 'cltbld', 09:10:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:00 INFO - 'MOZ_NO_REMOTE': '1', 09:10:00 INFO - 'NO_EM_RESTART': '1', 09:10:00 INFO - 'PAGER': '/bin/cat', 09:10:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:00 INFO - 'PWD': '/builds/slave/test', 09:10:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:00 INFO - 'SHELL': '/bin/bash', 09:10:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41cBG8sqXz/Listeners', 09:10:00 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:10:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:00 INFO - 'USER': 'cltbld', 09:10:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:00 INFO - 'XPC_FLAGS': '0x0', 09:10:00 INFO - 'XPC_SERVICE_NAME': '0', 09:10:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:00 INFO - Downloading/unpacking jsonschema 09:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:02 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:10:02 INFO - Downloading/unpacking functools32 (from jsonschema) 09:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:02 INFO - Downloading functools32-3.2.3-2.tar.gz 09:10:02 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:10:03 INFO - warning: no files found matching '*.txt' 09:10:03 INFO - no previously-included directories found matching 'build' 09:10:03 INFO - no previously-included directories found matching 'dist' 09:10:03 INFO - no previously-included directories found matching '.git*' 09:10:03 INFO - Installing collected packages: jsonschema, functools32 09:10:03 INFO - Running setup.py install for functools32 09:10:03 INFO - warning: no files found matching '*.txt' 09:10:03 INFO - no previously-included directories found matching 'build' 09:10:03 INFO - no previously-included directories found matching 'dist' 09:10:03 INFO - no previously-included directories found matching '.git*' 09:10:03 INFO - Successfully installed jsonschema functools32 09:10:03 INFO - Cleaning up... 09:10:03 INFO - Return code: 0 09:10:03 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:10: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')]} 09:10:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:10:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10: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')]} 09:10:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:10:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:10:03 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f27ea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2854c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7faa48d95130>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f122d30>, '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 0x10ef86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f119b20>, '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.DyfHGqgQTw/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.41cBG8sqXz/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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 09:10:03 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:10:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:10:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DyfHGqgQTw/Render', 09:10:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:03 INFO - 'HOME': '/Users/cltbld', 09:10:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:03 INFO - 'LOGNAME': 'cltbld', 09:10:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:03 INFO - 'MOZ_NO_REMOTE': '1', 09:10:03 INFO - 'NO_EM_RESTART': '1', 09:10:03 INFO - 'PAGER': '/bin/cat', 09:10:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:03 INFO - 'PWD': '/builds/slave/test', 09:10:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:03 INFO - 'SHELL': '/bin/bash', 09:10:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41cBG8sqXz/Listeners', 09:10:03 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:10:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:03 INFO - 'USER': 'cltbld', 09:10:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:03 INFO - 'XPC_FLAGS': '0x0', 09:10:03 INFO - 'XPC_SERVICE_NAME': '0', 09:10:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:03 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:10:04 INFO - Downloading/unpacking flake8 09:10: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 09:10: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 09:10: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 09:10: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 09:10: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 09:10: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 09:10:06 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:10:06 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:06 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:06 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:10:06 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:10:06 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:10:07 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:10:07 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:10:07 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 09:10:07 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 09:10:07 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 09:10:07 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 09:10:07 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 09:10:07 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 09:10:07 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:10:07 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 09:10:07 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 09:10:07 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 09:10:07 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 09:10:07 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 09:10:07 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 09:10:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:10:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:10:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:10:07 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:10:07 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:10:07 INFO - no previously-included directories found matching 'docs/_build' 09:10:07 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:10:08 INFO - Running setup.py install for pep8 09:10:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:10:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:10:08 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:10:08 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:10:08 INFO - no previously-included directories found matching 'docs/_build' 09:10:08 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:10:08 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:10:08 INFO - Cleaning up... 09:10:08 INFO - Return code: 0 09:10:08 INFO - Running post-action listener: _resource_record_post_action 09:10:08 INFO - Running post-action listener: _start_resource_monitoring 09:10:08 INFO - Starting resource monitoring. 09:10:08 INFO - ##### 09:10:08 INFO - ##### Running install step. 09:10:08 INFO - ##### 09:10:08 INFO - Running pre-action listener: _resource_record_pre_action 09:10:08 INFO - Running main action method: install 09:10:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:10:08 INFO - Reading from file tmpfile_stdout 09:10:08 INFO - Detecting whether we're running mozinstall >=1.0... 09:10:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:10:08 INFO - Reading from file tmpfile_stdout 09:10:08 INFO - Output received: 09:10:08 INFO - Usage: mozinstall [options] installer 09:10:08 INFO - Options: 09:10:08 INFO - -h, --help show this help message and exit 09:10:08 INFO - -d DEST, --destination=DEST 09:10:08 INFO - Directory to install application into. [default: 09:10:08 INFO - "/builds/slave/test"] 09:10:08 INFO - --app=APP Application being installed. [default: firefox] 09:10:08 INFO - mkdir: /builds/slave/test/build/application 09:10:08 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 09:10:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 09:10:40 INFO - Reading from file tmpfile_stdout 09:10:40 INFO - Output received: 09:10:40 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 09:10:40 INFO - Running post-action listener: _resource_record_post_action 09:10:40 INFO - ##### 09:10:40 INFO - ##### Running run-tests step. 09:10:40 INFO - ##### 09:10:40 INFO - Running pre-action listener: _resource_record_pre_action 09:10:40 INFO - Running main action method: run_tests 09:10:40 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:10:40 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:10:40 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:10:40 INFO - 2016-03-07 09:10:40.925 screenresolution[1647:7660] starting screenresolution argv=screenresolution get 09:10:40 INFO - 2016-03-07 09:10:40.928 screenresolution[1647:7660] Display 0: 1600x1200x32@60 09:10:40 INFO - 2016-03-07 09:10:40.933 screenresolution[1648:7662] starting screenresolution argv=screenresolution list 09:10:40 INFO - Available Modes on Display 0 09:10:40 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:10:40 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:10:40 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:10:40 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:10:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:10:41 INFO - Intel Iris: 09:10:41 INFO - Chipset Model: Intel Iris 09:10:41 INFO - Type: GPU 09:10:41 INFO - Bus: Built-In 09:10:41 INFO - VRAM (Dynamic, Max): 1536 MB 09:10:41 INFO - Vendor: Intel (0x8086) 09:10:41 INFO - Device ID: 0x0a2e 09:10:41 INFO - Revision ID: 0x0009 09:10:41 INFO - Displays: 09:10:41 INFO - Display: 09:10:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:10:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:10:41 INFO - Display Serial Number: 1600x1200 60 09:10:41 INFO - Main Display: Yes 09:10:41 INFO - Mirror: Off 09:10:41 INFO - Online: Yes 09:10:41 INFO - Rotation: Supported 09:10:41 INFO - Return code: 0 09:10:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:10:41 INFO - Python 2.7.3 09:10:41 INFO - Return code: 0 09:10:41 INFO - grabbing minidump binary from tooltool 09:10:41 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')]} 09:10:41 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 0x10f122d30>, '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 0x10ef86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f119b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:10:41 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 09:10:41 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 09:10:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:10:41 INFO - Return code: 0 09:10:41 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:10:41 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:10:41 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:10:41 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:10:41 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:10:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:10:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:10:42 INFO - Return code: 0 09:10:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:10:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0150 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:10:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.DyfHGqgQTw/Render', 09:10:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:10:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:10:42 INFO - 'HOME': '/Users/cltbld', 09:10:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:10:42 INFO - 'LOGNAME': 'cltbld', 09:10:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:10:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:10:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:10:42 INFO - 'MOZ_NO_REMOTE': '1', 09:10:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:10:42 INFO - 'NO_EM_RESTART': '1', 09:10:42 INFO - 'PAGER': '/bin/cat', 09:10:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:10:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:10:42 INFO - 'PWD': '/builds/slave/test', 09:10:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:10:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:10:42 INFO - 'SHELL': '/bin/bash', 09:10:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.41cBG8sqXz/Listeners', 09:10:42 INFO - 'TMPDIR': '/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/', 09:10:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:10:42 INFO - 'USER': 'cltbld', 09:10:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:10:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:10:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:10:42 INFO - 'XPC_FLAGS': '0x0', 09:10:42 INFO - 'XPC_SERVICE_NAME': '0', 09:10:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:10:42 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0150', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:10:42 INFO - mozversion application_buildid: 20160307063925 09:10:42 INFO - mozversion application_changeset: 8849dd1a4a796c2fd70d6f002912c3f799c59e69 09:10:42 INFO - mozversion application_display_name: FirefoxDeveloperEdition 09:10:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:10:42 INFO - mozversion application_name: Firefox 09:10:42 INFO - mozversion application_remotingname: firefox-dev 09:10:42 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:10:42 INFO - mozversion application_vendor: Mozilla 09:10:42 INFO - mozversion application_version: 47.0a2 09:10:42 INFO - mozversion platform_buildid: 20160307063925 09:10:42 INFO - mozversion platform_changeset: 8849dd1a4a796c2fd70d6f002912c3f799c59e69 09:10:42 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 09:10:42 INFO - mozversion platform_version: 47.0a2 09:10:42 INFO - using testdate: 1457370642 09:10:42 INFO - actual date: 1457370642 09:10:42 INFO - starting webserver on 'localhost:49272' 09:10:42 INFO - SUITE-START | Running 2 tests 09:10:42 INFO - TEST-START | dromaeo_css 09:10:42 INFO - operating with platform_type : mac_ 09:10:42 INFO - Initialising browser for dromaeo_css test... 09:10:42 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmp92Y7FV/profile http://localhost:49272/getInfo.html) 09:10:45 INFO - PROCESS | 1666 | __metrics Screen width/height:1600/1200 09:10:45 INFO - PROCESS | 1666 | colorDepth:24 09:10:45 INFO - PROCESS | 1666 | Browser inner width/height: 1024/689 09:10:45 INFO - PROCESS | 1666 | __metrics 09:10:45 ERROR - PROCESS | 1666 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:10:46 INFO - TEST-INFO | 1666: exit 0 09:10:46 INFO - Browser initialized. 09:10:46 INFO - Running cycle 1/1 for dromaeo_css test... 09:10:46 INFO - TEST-INFO | started process 1670 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmp92Y7FV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:10:58 INFO - PROCESS | 1670 | RSS: Main: 219398144 09:10:58 INFO - PROCESS | 1670 | 09:11:48 INFO - PROCESS | 1670 | 1457370708054 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] 09:13:58 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49272/tests/dromaeo/cssquery-ext.html) 09:14:00 INFO - PROCESS | 1670 | RSS: Main: 232001536 09:14:00 INFO - PROCESS | 1670 | 09:17:01 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-ext.html (next: http://localhost:49272/tests/dromaeo/cssquery-jquery.html) 09:17:02 INFO - PROCESS | 1670 | RSS: Main: 242343936 09:17:02 INFO - PROCESS | 1670 | 09:20:04 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49272/tests/dromaeo/cssquery-mootools.html) 09:20:04 INFO - PROCESS | 1670 | RSS: Main: 245653504 09:20:04 INFO - PROCESS | 1670 | 09:23:06 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49272/tests/dromaeo/cssquery-prototype.html) 09:23:07 INFO - PROCESS | 1670 | RSS: Main: 246042624 09:23:07 INFO - PROCESS | 1670 | 09:26:09 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49272/tests/dromaeo/cssquery-yui.html) 09:26:10 INFO - PROCESS | 1670 | RSS: Main: 248807424 09:26:10 INFO - PROCESS | 1670 | 09:29:12 INFO - PROCESS | 1670 | Cycle 1(1): loaded http://localhost:49272/tests/dromaeo/cssquery-yui.html (next: http://localhost:49272/tests/dromaeo/cssquery-dojo.html) 09:29:12 INFO - PROCESS | 1670 | RSS: Main: 250478592 09:29:12 INFO - PROCESS | 1670 | 09:29:12 INFO - PROCESS | 1670 | __start_tp_report 09:29:12 INFO - PROCESS | 1670 | _x_x_mozilla_page_load 09:29:12 INFO - PROCESS | 1670 | _x_x_mozilla_page_load_details 09:29:12 INFO - PROCESS | 1670 | |i|pagename|runs| 09:29:12 INFO - PROCESS | 1670 | |0;dojo.html;3251.382237374899;3544.32657795019;3607.368710475666;3619.891403257903;3641.1989362340278;5787.710614469275;5866.882662346761;5869.14897339886;5880.6765627890445;5886.676232807194;5834.183214349984;5880.2355693759855;5892.9705351473185;5894.440028197314;5953.017752070903;5296.788128474856;5300.708461034642;5375.462453754632;5379.139337705968;5380.623356365037;5297.390800058004;5366.570674346043;5390.380106287768;5414.40441551431;5427.701476418795;5408.675479471224;5421.512063914247;5424.349078110613;5430.511253987141;5443.428440013801;4363.301871700529;5355.143177091647;5389.973050134763;5436.238926550286;5448.128299472065;5210.452902445264;5222.973885130588;5292.153255479144;5308.575313974873;5318.441563635801;5631.155326700987;5681.971590142023;5710.14347847822;5747.971260143714;5780.2196703444915;6181.536384771161;6242;6298.149749783812;6305.653189074599;6306.400891915261;6238.313785483593;6290.779822706229;6293.402126797947;6308.526860485482;6312.905306420407;4879.7804098816;5877.85305367365;5926.762929482772;5968.612040217372;6013.128096425994;5651.830445086572;6168.797084568556;6239.688015599202;6369.9681501592195;6409.359064093646;6234.470070044006;6247.875042499216;6275;6278.215223097113;6287.1826662534495;6282.717277722513;6310.05349197624;6321.146645202839;6324.525660575475;6327.936720632827;6173.32093469718;6264.780732674426;6282.403171698681;6302.4958003359625;6303.842403939847;6210.068489726486;6253.937460625336;6262.874742505124;6278.748850046039;6287.371262873768;4973.502649734997;4976.90046199074;4988.501149885055;5002.74986250686;5009;4323.524412314643;4371.388005679208;4446.822127114944;4457.910841783211;4517.073999830027;5851.502622277069;5953.553483488756;5954.910676339859;5995.010823214121;5998.070299103646;5362;5788.913166302509;6276.968615156895;6291.905621415683;6317.431431171217;5834.124881267844;5953.077273022688;5965.284165900033;6009.519238460913;6051.878962420815;5482.91775623366;5494.148406996922;5497.038018346773;5509.090999984957;5524.475174858382;6510.121133646991;6543.901841472287;6549.9345006550275;6564.901526477202;6570.5729127606555;6163.9383606163365;6225.408586184305;6255.593386429868;6295.685215739286;6307.810765677037;5158.38099428056;5370.543503802221;5534.889302213853;6533.020046992799;6539.247986481616;6256.061590761422;6293.213348331458;6298.370162983665;6303.1175635412;6308.873822523616;6213.285472170577;6257.4681152102585;6259.874802504016;6302.558820882494;6324.7153878076515;6205.441510263918;6225.968870155621;6235.719392627252;6256.280527739368;6267.091271765659;4856.757162141808;6061;6235.75056997715;6264.248290205022;6271;6023.698815059141;6041.335453100243;6065.120557519047;6089.086637004308;6106.480949119375;6228.719707613259;6237.438630523275;6242.906356404748;6245.812625621239;6258.968705156445;6096.725647345791;6114.785982490592;6115.3578874217565;6129.387061294014;6154.353792851865 09:29:12 INFO - PROCESS | 1670 | |1;ext.html;570.9124118554156;580.7531798985433;615.4122812713858;619.4239357397619;634.6667999300367;38692.67843929366;39282;39331.80334098333;39431.605683943155;39589.604103958955;40689.57586484474;40769.980750481176;41163.38254926178;41240.38139427911;41301.79349103258;8909.821803563926;9461.81076378472;9653.806923861519;9660.806783864318;9661.130498255156;9541.522923853814;9822.557984890696;9847.458389788559;9853.521971704266;9865.112139907407;8395.95802020989;9807.460589667566;9869.95065024674;9908.405495670248;9910.55402506889;9727.319087663866;9834.360766550151;9840.55717492711;9845.90154098457;9868.901310986907;9613.807723845553;9708.61165553377;9735.26985476085;9743.853842192373;9769.853452198222;40259.39610905839;40489.78530644056;40505.98735031618;40588.39117413241;40619;3261.673832616743;3361.6638336166434;3432.8970130896114;3462.6537346265422;3723.2553489301977;28432.28919277014;29268.853655731797;29292.974745884007;29549.40901181986;29632.70367296321;2589.1714651311586;2700.257429206964;2786.7352601502826;2822.5483922572494;2935.6917523660136;449188;451701;452278;452755.73622132005;453609;47254;47635;70989;71624;71673.28326716665;46632;46973.825654358916;47023.29465058027;47032.5296747035;47209.5279047212;16384.0169589825;16530.58673533171;16535.421260255833;16599;16645.7515686324;13151.473941042443;13167.53913613019;13222.933885330513;13254.337283135805;13255.138416003121;13465.990050746233;14916.477923272634;15229.390824366901;15564.377424903103;15771.369145234292;5954.672493012839;6341.175647165839;6754.493412994045;6913.516053876281;6928.688209030605;981.7005813226891;1055.4300677634146;1056.1761825775907;1074.5540055166387;1167.8189880568525;24763.876180618983;27895.72104278972;29792.404151917275;29949.401011980073;30593.38813223723;907.9364444488822;1105.1435137768133;1162.91859569831;1167.2121318110242;1231.3664982704165;14554.781678274834;14557.272136393138;14695.41218351254;14815.70368592622;14838.925805370904;525727;528274;529921;535757.6424235707;536633;61894;62208;62268.37731622716;62498;62526.0621090684;1511.3954418232795;1525.8855585831107;1543.53693891832;1549.775282584019;1565.1078885035647;28379.00673476501;28451.857740711162;28689;28911.855440722662;29064;51486.74256628693;51555;51676;51794.741026296135;52036.73981630067;508615;509516;509657;512635;513404;33238.833805830815;34426.31147377088;35189.76835810734;35255.29489410146;35276.82361588176;45866.770666146454;46022.84942876455;46134;47512.812179695786;48360.27459588179;37892.263467066616;37982.43026354552;38372.808135959145;38406.65576704802;38629.03427414225;35690.92927212188;37819.43270850994;37927.24145517129;38386.42420363753;38657.806710966266;32560.837195814816;37352;37726.43410348902;37971.81014094912;38892.61107389003;29847.798767229997;31409.685903140675;31452.842735786173;31581;31612.525812113297;20299.28952486656;24149.637755434032;24458.89934952967;24685.62971555392;24791.76041197969 09:29:12 INFO - PROCESS | 1670 | |2;jquery.html;346.57717584546845;359.11657322985445;378.25483796920076;388.9377699568069;390.3715018819702;15468.226588670565;20182.293619723314;20977.056032478537;20995.160193592237;21020.054097565608;12281.201721888094;12407.751844963095;12453.813192802092;12456.875431245684;12465.750684986317;5296.417394086657;5489.560835133199;5650.632708873931;6099.9085013724825;6105.755769769204;5895.380984996578;5910;5973.820785376446;5991.041433370661;6006.909896351558;5637.689927054011;5817.272840894888;5889.528837692974;5900.144479050535;5916.911246331309;5539.377531805221;5784.13238014297;5800.303963524362;5841.269841269841;5986.790462333841;5819.301683797971;5819.883602327972;5831.037878750001;5831.096180092092;5831.766729330821;12797;12881.806772898413;19954;23966.400839978967;24095.638565421534;2109.430453777487;2116.153538584563;2384.892679829412;2784.5127102756937;2848.4872722909868;9858.507074646312;9974.601015959353;10002.499875006293;10322.690319290434;10421.218408619385;1791.8566514678926;1823.1157888424104;1855.5082903030707;1864.4127099963468;1865.8880467172014;108698;110728;113189.43405283004;116723;118455;11932;11973.46119424628;12052.156349055482;12086.214396064228;12144.332061736513;11690;11781.823272650918;12051.337176455203;12772.680682982815;14647.340869660891;6871.931280687129;7962.686156784182;9053.637854485747;9103.954480227556;9168.037356077515;9253.72238832836;9278.814423711623;9280.767980800534;9287.978322384532;9389.765255868659;4587.977060114678;4618.1918164321105;4663.556962088596;4665.4634717007975;4674.555917187861;1969.4879331373945;2031.14691829432;2031.6749320109006;2065.1429656692303;2084.4997200672033;869.517417833096;921.4701546610592;971.946542940145;973.5667627905514;1065.824139017069;18244.361447349278;19814.60370792605;20093.598128037356;20246;20731.585368292548;926.6895589977298;951.6383774165911;979.5347210075299;1005.3465247589126;1029.6190409548515;10765.569377224823;10930.070943969693;10976.012158905736;10985.780284394268;10996.12031037515;650214;653172;658515;670131;671386;97744.51127744316;102318;110179.44910275398;113214;113375;972.6304004478394;988.728099772554;1003.372891942536;1005.4570531912832;1006;17523.386681466596;17681.91159044248;17813.643727125644;18224.635507289513;18313.908430457763;51181.48818511916;52199;53909;54625.72687136539;55996.440035599124;61791;73124.26875731387;73254.26745732687;73493.69278382379;77022;11257.605983790529;11605.477753500943;11781;11950.163488555718;12024.398780060787;13827.585172444842;13842.100263482842;13853.722925541231;14155.575332740034;14191.361388737325;11569.942150289195;11818.46816893259;11992.700182495508;12101.636950891487;12120.454579544117;11696.590619328283;11931.284122952651;12056.336901470153;12226;12863.356832158543;8266.669333226604;11534.077273818242;12165;12237.326947017644;12459.563915262923;9307.627694892399;9383.812323753624;10157.593696252066;10754.677359679223;12362;12140.514379424723;12171.39143042862;12294.20087694297;12321.630351089481;12350.81473777876 09:29:12 INFO - PROCESS | 1670 | |3;mootools.html;1597.369039229504;1666.5083800278917;1670.6909221793974;1773.67187070392;1955.8044195580435;8204.138565450616;8785.692500762474;8946.194842464178;9191.954040229797;9244.722658320252;8990;9003.684871029514;9085.364024518287;9097.13577210164;9098.090190980898;2127.6276651585986;2525.88633511492;2541.1106112860443;2541.2884392370074;2542.034027069711;2454.7054353477606;2540.0220914947695;2544.2367289812983;2551.068859866154;2554.0549996501322;2522.255934499327;2540.0347867810206;2576.407426291954;2580.6129080637866;2581.4966081613998;2119.5760847830343;2528.9620655690087;2540.733223011576;2542.2627438042946;2559.5904655255163;2526.7473252674768;2528.9494210115877;2532.2403279016407;2538.936526586832;2579.8968041278326;7461.328480436787;8325.125861784485;9082.500462474562;9180.632774689071;9196.954015229881;5513.365962914276;5643.6049476536655;5686.744096515626;5717.171010203539;5767.711614419304;3523.6300188480095;3525.008370270789;3552.769070010441;3642.1805093853936;3688.465172549992;1031.6389263757699;1044.8276034454307;1045.3466583385384;1048.8531605575226;1050.03921411908;12241.449134788867;12379.690507737288;12413.317267550281;12421.565245216465;12495.25028498293;4539.0694907543875;4956.083124621957;5031.748412579356;5063.696178229318;5068.6451948364;9813.754656133653;10438;10528;10529.473526323653;10533.315334503233;5617.887642247132;5631.605787594911;5642.802501912413;5642.971785141131;5686.317641883001;4508.571685689854;4982.3522942018035;5058.570021548136;5064.037832811754;5135.589152867761;4013.57857424972;4070.430139780433;4088.8773336799945;4111.8972025698995;4119.279126152911;1357.7895426208954;1362.8500864904852;1367.9726405471836;1373.8282714660668;1377.5936098850664;1357.457017193111;1400.5308221745624;1406.177386229047;1409.9002777833307;1415.7027024325007;8383.455075420079;8445.662173513114;8504.744857654281;8505.362097842686;8512.829743405096;531.4093792760293;540.8188256933971;542.4521233554138;542.7421974562052;544.7848100000557;6192.845178870474;6247.5939063960695;6297.338779428185;6308.463780578611;6335.176427064452;10790.730231744112;11181.888181118247;11195.552177912792;11232.606858759904;11279.154063445274;10703.571857125628;11030.834537481944;11038.392888391216;11081.445927703744;11306;8640.524771137521;8699.43453675509;8731.694390696295;8777.29781617469;8781.912180878237;7931.801704957422;8086.070101938352;8095.39284553649;8138.145494723206;8146.674133034612;9664.420134791935;9986.001399859955;9994.300398972002;10006.14947729422;10092;10190.745231369276;10384;10386.221033422373;10416;10591.523381448007;7378.114626244885;7562.962185189039;7611;7617.047869016373;7757.1079325878245;8393.202645748644;8399.664013439395;8425.410221284452;8446.282066024456;8473.57632118404;7357.705691772269;7500.099988001475;7587.734429294948;7605.771826845204;7723.961380193063;7412.888806667796;7468.029156209658;7518.398528117847;7579.962100189464;7605.885911711218;6531.575447595891;7339.229380914927;7871.527708337518;7938.3252423544645;7940;7083.468739844429;7154.998300237867;7170.677319520739;7178.712851485882;7196.172440169447;7165.283471652793;7186.7125314986815;7187.712491500281;7205.207427183111;7239.746608868664 09:29:12 INFO - PROCESS | 1670 | |4;prototype.html;336.9241920567872;340.3754111205937;342.4315636044164;347.2014366956001;348.3729287282891;6874.793756187316;6911.377975982161;6921.134858142732;6929.514933954612;6954.547954382968;5510.283663123799;6873.690683919223;6899.551529150602;6949.235584085746;6956.860862782742;4882.707037577739;4987.226979818134;5110.28456016158;5118.129917913963;5133.307003554528;3915.5105611798526;5093.224192814906;5097.108006098936;5108.335916330871;5160.509751573594;4173.895652608694;5013.548780609744;5089.923651145235;5116.846494605168;5117.974410127963;4195.601417865298;5055.241713742931;5114.156164232897;5126.589872810204;5135.589152867761;4368.978155109236;4388.605025547684;4396.1867054595;4396.296592545209;4397.516273209944;5548.278723765925;6321.494280457552;6642.66786660665;6673.499487538405;6746.966265168692;5495.395506494282;5825.679587622679;5873.500752436048;5929.6145750526075;5954.821355359346;5917.615355001911;7380;7405.666744996488;7407.074115735533;7438.590877501735;4326.134773045404;4733.408323959505;4735.337052812609;4735.455422626407;4754.429468463806;5779.422057794229;5915.3493115757665;6855.5886646801355;7786.610669466504;7890.8816367754525;4266.33871749873;4509.346144808985;4703.435587729495;4823.782929768169;4847.878803029953;4913.852584422473;4920.458749537548;4920.72935988524;4929.285253638202;4936.03747269279;5873.765049398062;5899.823005309848;5904.3210030847;5920.5559583031445;5921.911171332434;5658.688772117573;7453.888191677129;7464.253574642492;7493.66278517468;7498.550086994798;1510.2146883620455;1517.521980576115;1603.510929166592;1659.2035822805121;1682.6634673065191;1068.8663917010374;1085.5386460754148;1089.9727506812235;1092.9617463388743;1097.1277834121893;6897.41371983377;6958.956156576554;6994.825129371807;7005.824854378681;7029.648517574101;7677.078750549858;7688.577128257888;7705.9229407706325;7709.344705699966;7732.265434783687;6967.024616553686;6974.895376569356;6977.232504424509;6980.080477868525;6987.26633703464;4014.7189696720948;4029.4560234368573;4065.2072845794787;4077.5922407758985;4080.224757296104;8184.263416292562;8220.958895205486;8221.780119367737;8261;8267.875981860278;8094.878576821352;8094.919050809416;8095.433319667567;8098.878516822252;8142.918570814334;8219.178082191733;8235.917640823634;8240.258376746002;8243.422960392714;8246.793830154294;6379.585326953733;7533.623318834146;7756.534607923542;7797.649105790139;7823.84352312962;7613.010308659839;7621.085469743666;7622.390208783395;7623.085229772463;7626.9618651906385;8172.101068882537;8185.672573097248;8203.179682031749;8214.740946239594;8234.876476852973;4214.4310518079665;4763.190257656276;4811.518848115161;4815.566599006106;4836.202026665561;7449.478536502393;7498.137714162723;7623.618819059136;7762.029746281715;7800.726974555863;7396.667149978156;7400.777976660709;7445.739399121005;7451.478396512192;7454.552726836408;7428.1086269647985;7437.590932498764;7439.665215065227;7444.516106453063;7484.738034168778;7242.3843973262865;7277;7289.5261807982315;7290.4896657233485;7335.77992660221;5744.540436765133;7437.219091995263;7446.553206807609;7451.254874512505;7499.887501687588;5851.970740146442;7273.927260727325;7274.199838017708;7286.599237041802;7304.160021597584 09:29:12 INFO - PROCESS | 1670 | |5;yui.html;757.7499425189686;763.9618019099044;773.7872085176575;787.8778789287662;788.1409263902345;15160.620984475394;15183;15293.235338233071;15333.386664533433;15364.462243821468;12318.876811231885;14265.1440913545;14271.286435678201;14286.714265714705;14291.428342866273;610.2341561340522;786.5949036246309;959.6689142245914;974.1573538888881;974.5663179884954;952.8046750416148;965.4448692002092;966.7244835221964;966.7824739433642;969.1568335548083;999.7350702063959;1012.7215015870657;1016.6899095775785;1017.5471914997829;1017.64382466137;841.2554888923316;880.3573391424233;988.4365911430488;1005.3615953869272;1020.285799940045;744.4714252880461;751.5528260684883;771.0824119298018;772.2740623813653;774.9263819937097;15224.391024359013;15475.303611337516;15493.302801373966;15507.844921550866;15523.3014514346;10945.398003109825;12793.296368699717;12845.229286242762;12959;13143.27711975841;10048.397096174253;10162.39025658463;10199.368101103863;10310.432926189056;10314.535845886952;3008.3983203359417;3489.5289135966573;3535.699465545406;3620.1311685195365;3717.3494638438165;80345;80995;82082.58958705228;82395.5880220595;82984.58507707484;9300.162985331353;9464.668736594185;9615.615375385047;9732.902670973199;9759.804803903882;21254.893725531274;21316.78683213148;21335.573288534142;21360.893195534234;21407.46481337979;7577.583232922242;7581.166071732105;7648.579328136894;7675.5010924289745;7737.806554836062;4147.52303485097;4164.7709375984;4200.1179752252365;4215.009472773896;4222.303319952173;3755.830987605564;3794.6774524165753;3803.220339830328;3813.9427908581392;3875.2636998970106;683.586430209716;690.7271627707028;692.1037256752518;698.1517456290632;699.4474365251394;495.7546014722735;581.8429024163452;604.4106995679177;616.1774031667684;621.3910367839543;6738.764143255061;8329.6668133274;8454.239118479367;8547.871781923277;8581.785455363666;534.9572034237252;591.4913174669781;599.1312596734753;631.0817760158958;631.7757196195284;3296.4725643896863;3874.4575759393706;3918;3929.4891664084057;4001.4790681870236;92604.61093083609;93340;93624;95170.52414737882;99717;77364.61317693375;79521.20478795253;79709.60145199353;79761.60119199367;81031.59484202541;49548.50451495511;55064.72467637636;67936.6603166981;69599;72597.27402726011;8413.915860841313;8575.442596231225;8695.956520217358;8764.912350876664;8775.56122193875;46259;47775.76112119417;48707.75646121747;49026.50973490362;49205;64443.67778161079;65701.34298656952;66192;66220;66311;10777.784444311226;10855.40295283767;11176.72058198519;11277.492512837107;11509.482073306554;11938.64184074479;11998.580049698568;12357;12366;12527.18573292733;11358.792007809132;11418.543258269576;11479.713007174887;11526.654200374001;11984.04127669767;9882.901170988198;10894.891051089704;11653.067754579444;11859.288442693465;11921.701957451132;11223.60717374888;11295.152863535432;11320.60377886803;11415.315081095161;11766.764664706829;9708.563114659715;9726;9778.145431350798;9847.556859941176;10023.849642255225;9458.905410946078;9609.615615375307;9628.32601717873;9630.855537167088;9777 09:29:12 INFO - PROCESS | 1670 | __end_tp_report 09:29:12 INFO - PROCESS | 1670 | __start_cc_report 09:29:12 INFO - PROCESS | 1670 | _x_x_mozilla_cycle_collect,357 09:29:12 INFO - PROCESS | 1670 | __end_cc_report 09:29:12 INFO - PROCESS | 1670 | __startTimestamp1457371752899__endTimestamp 09:29:12 INFO - PROCESS | 1670 | 09:29:12 INFO - PROCESS | 1670 | ------- Summary: start ------- 09:29:12 INFO - PROCESS | 1670 | Number of tests: 6 09:29:12 INFO - PROCESS | 1670 | 09:29:12 INFO - PROCESS | 1670 | [#0] dojo.html Cycles:165 Average:5812.16 Median:6041.34 stddev:644.99 (10.7%) stddev-sans-first:614.89 09:29:12 INFO - PROCESS | 1670 | Values: 3251.4 3544.3 3607.4 3619.9 3641.2 5787.7 5866.9 5869.1 5880.7 5886.7 5834.2 5880.2 5893.0 5894.4 5953.0 5296.8 5300.7 5375.5 5379.1 5380.6 5297.4 5366.6 5390.4 5414.4 5427.7 5408.7 5421.5 5424.3 5430.5 5443.4 4363.3 5355.1 5390.0 5436.2 5448.1 5210.5 5223.0 5292.2 5308.6 5318.4 5631.2 5682.0 5710.1 5748.0 5780.2 6181.5 6242.0 6298.1 6305.7 6306.4 6238.3 6290.8 6293.4 6308.5 6312.9 4879.8 5877.9 5926.8 5968.6 6013.1 5651.8 6168.8 6239.7 6370.0 6409.4 6234.5 6247.9 6275.0 6278.2 6287.2 6282.7 6310.1 6321.1 6324.5 6327.9 6173.3 6264.8 6282.4 6302.5 6303.8 6210.1 6253.9 6262.9 6278.7 6287.4 4973.5 4976.9 4988.5 5002.7 5009.0 4323.5 4371.4 4446.8 4457.9 4517.1 5851.5 5953.6 5954.9 5995.0 5998.1 5362.0 5788.9 6277.0 6291.9 6317.4 5834.1 5953.1 5965.3 6009.5 6051.9 5482.9 5494.1 5497.0 5509.1 5524.5 6510.1 6543.9 6549.9 6564.9 6570.6 6163.9 6225.4 6255.6 6295.7 6307.8 5158.4 5370.5 5534.9 6533.0 6539.2 6256.1 6293.2 6298.4 6303.1 6308.9 6213.3 6257.5 6259.9 6302.6 6324.7 6205.4 6226.0 6235.7 6256.3 6267.1 4856.8 6061.0 6235.8 6264.2 6271.0 6023.7 6041.3 6065.1 6089.1 6106.5 6228.7 6237.4 6242.9 6245.8 6259.0 6096.7 6114.8 6115.4 6129.4 6154.4 09:29:12 INFO - PROCESS | 1670 | 09:29:12 INFO - PROCESS | 1670 | [#1] ext.html Cycles:180 Average:63837.42 Median:39381.70 stddev:132798.71 (337.2%) stddev-sans-first:133086.29 09:29:12 INFO - PROCESS | 1670 | Values: 570.9 580.8 615.4 619.4 634.7 38692.7 39282.0 39331.8 39431.6 39589.6 40689.6 40770.0 41163.4 41240.4 41301.8 8909.8 9461.8 9653.8 9660.8 9661.1 9541.5 9822.6 9847.5 9853.5 9865.1 8396.0 9807.5 9870.0 9908.4 9910.6 9727.3 9834.4 9840.6 9845.9 9868.9 9613.8 9708.6 9735.3 9743.9 9769.9 40259.4 40489.8 40506.0 40588.4 40619.0 3261.7 3361.7 3432.9 3462.7 3723.3 28432.3 29268.9 29293.0 29549.4 29632.7 2589.2 2700.3 2786.7 2822.5 2935.7 449188.0 451701.0 452278.0 452755.7 453609.0 47254.0 47635.0 70989.0 71624.0 71673.3 46632.0 46973.8 47023.3 47032.5 47209.5 16384.0 16530.6 16535.4 16599.0 16645.8 13151.5 13167.5 13222.9 13254.3 13255.1 13466.0 14916.5 15229.4 15564.4 15771.4 5954.7 6341.2 6754.5 6913.5 6928.7 981.7 1055.4 1056.2 1074.6 1167.8 24763.9 27895.7 29792.4 29949.4 30593.4 907.9 1105.1 1162.9 1167.2 1231.4 14554.8 14557.3 14695.4 14815.7 14838.9 525727.0 528274.0 529921.0 535757.6 536633.0 61894.0 62208.0 62268.4 62498.0 62526.1 1511.4 1525.9 1543.5 1549.8 1565.1 28379.0 28451.9 28689.0 28911.9 29064.0 51486.7 51555.0 51676.0 51794.7 52036.7 508615.0 509516.0 509657.0 512635.0 513404.0 33238.8 34426.3 35189.8 35255.3 35276.8 45866.8 46022.8 46134.0 47512.8 48360.3 37892.3 37982.4 38372.8 38406.7 38629.0 35690.9 37819.4 37927.2 38386.4 38657.8 32560.8 37352.0 37726.4 37971.8 38892.6 29847.8 31409.7 31452.8 31581.0 31612.5 20299.3 24149.6 24458.9 24685.6 24791.8 09:29:12 INFO - PROCESS | 1670 | 09:29:12 INFO - PROCESS | 1670 | [#2] jquery.html Cycles:180 Average:35725.30 Median:2031.41 stddev:109174.01 (5374.3%) stddev-sans-first:109447.95 09:29:12 INFO - PROCESS | 1670 | Values: 346.6 359.1 378.3 388.9 390.4 15468.2 20182.3 20977.1 20995.2 21020.1 12281.2 12407.8 12453.8 12456.9 12465.8 5296.4 5489.6 5650.6 6099.9 6105.8 5895.4 5910.0 5973.8 5991.0 6006.9 5637.7 5817.3 5889.5 5900.1 5916.9 5539.4 5784.1 5800.3 5841.3 5986.8 5819.3 5819.9 5831.0 5831.1 5831.8 12797.0 12881.8 19954.0 23966.4 24095.6 2109.4 2116.2 2384.9 2784.5 2848.5 9858.5 9974.6 10002.5 10322.7 10421.2 1791.9 1823.1 1855.5 1864.4 1865.9 108698.0 110728.0 113189.4 116723.0 118455.0 11932.0 11973.5 12052.2 12086.2 12144.3 11690.0 11781.8 12051.3 12772.7 14647.3 6871.9 7962.7 9053.6 9104.0 9168.0 9253.7 9278.8 9280.8 9288.0 9389.8 4588.0 4618.2 4663.6 4665.5 4674.6 1969.5 2031.1 2031.7 2065.1 2084.5 869.5 921.5 971.9 973.6 1065.8 18244.4 19814.6 20093.6 20246.0 20731.6 926.7 951.6 979.5 1005.3 1029.6 10765.6 10930.1 10976.0 10985.8 10996.1 650214.0 653172.0 658515.0 670131.0 671386.0 97744.5 102318.0 110179.4 113214.0 113375.0 972.6 988.7 1003.4 1005.5 1006.0 17523.4 17681.9 17813.6 18224.6 18313.9 51181.5 52199.0 53909.0 54625.7 55996.4 61791.0 73124.3 73254.3 73493.7 77022.0 11257.6 11605.5 11781.0 11950.2 12024.4 13827.6 13842.1 13853.7 14155.6 14191.4 11569.9 11818.5 11992.7 12101.6 12120.5 11696.6 11931.3 12056.3 12226.0 12863.4 8266.7 11534.1 12165.0 12237.3 12459.6 9307.6 9383.8 10157.6 10754.7 12362.0 12140.5 12171.4 12294.2 12321.6 12350.8 09:29:12 INFO - PROCESS | 1670 | 09:29:12 INFO - PROCESS | 1670 | [#3] mootools.html Cycles:180 Average:6218.04 Median:2833.50 stddev:3321.86 (117.2%) stddev-sans-first:3313.02 09:29:12 INFO - PROCESS | 1670 | Values: 1597.4 1666.5 1670.7 1773.7 1955.8 8204.1 8785.7 8946.2 9192.0 9244.7 8990.0 9003.7 9085.4 9097.1 9098.1 2127.6 2525.9 2541.1 2541.3 2542.0 2454.7 2540.0 2544.2 2551.1 2554.1 2522.3 2540.0 2576.4 2580.6 2581.5 2119.6 2529.0 2540.7 2542.3 2559.6 2526.7 2528.9 2532.2 2538.9 2579.9 7461.3 8325.1 9082.5 9180.6 9197.0 5513.4 5643.6 5686.7 5717.2 5767.7 3523.6 3525.0 3552.8 3642.2 3688.5 1031.6 1044.8 1045.3 1048.9 1050.0 12241.4 12379.7 12413.3 12421.6 12495.3 4539.1 4956.1 5031.7 5063.7 5068.6 9813.8 10438.0 10528.0 10529.5 10533.3 5617.9 5631.6 5642.8 5643.0 5686.3 4508.6 4982.4 5058.6 5064.0 5135.6 4013.6 4070.4 4088.9 4111.9 4119.3 1357.8 1362.9 1368.0 1373.8 1377.6 1357.5 1400.5 1406.2 1409.9 1415.7 8383.5 8445.7 8504.7 8505.4 8512.8 531.4 540.8 542.5 542.7 544.8 6192.8 6247.6 6297.3 6308.5 6335.2 10790.7 11181.9 11195.6 11232.6 11279.2 10703.6 11030.8 11038.4 11081.4 11306.0 8640.5 8699.4 8731.7 8777.3 8781.9 7931.8 8086.1 8095.4 8138.1 8146.7 9664.4 9986.0 9994.3 10006.1 10092.0 10190.7 10384.0 10386.2 10416.0 10591.5 7378.1 7563.0 7611.0 7617.0 7757.1 8393.2 8399.7 8425.4 8446.3 8473.6 7357.7 7500.1 7587.7 7605.8 7724.0 7412.9 7468.0 7518.4 7580.0 7605.9 6531.6 7339.2 7871.5 7938.3 7940.0 7083.5 7155.0 7170.7 7178.7 7196.2 7165.3 7186.7 7187.7 7205.2 7239.7 09:29:12 INFO - PROCESS | 1670 | 09:29:12 INFO - PROCESS | 1670 | [#4] prototype.html Cycles:180 Average:6007.37 Median:6886.10 stddev:1985.71 (28.8%) stddev-sans-first:1945.13 09:29:12 INFO - PROCESS | 1670 | Values: 336.9 340.4 342.4 347.2 348.4 6874.8 6911.4 6921.1 6929.5 6954.5 5510.3 6873.7 6899.6 6949.2 6956.9 4882.7 4987.2 5110.3 5118.1 5133.3 3915.5 5093.2 5097.1 5108.3 5160.5 4173.9 5013.5 5089.9 5116.8 5118.0 4195.6 5055.2 5114.2 5126.6 5135.6 4369.0 4388.6 4396.2 4396.3 4397.5 5548.3 6321.5 6642.7 6673.5 6747.0 5495.4 5825.7 5873.5 5929.6 5954.8 5917.6 7380.0 7405.7 7407.1 7438.6 4326.1 4733.4 4735.3 4735.5 4754.4 5779.4 5915.3 6855.6 7786.6 7890.9 4266.3 4509.3 4703.4 4823.8 4847.9 4913.9 4920.5 4920.7 4929.3 4936.0 5873.8 5899.8 5904.3 5920.6 5921.9 5658.7 7453.9 7464.3 7493.7 7498.6 1510.2 1517.5 1603.5 1659.2 1682.7 1068.9 1085.5 1090.0 1093.0 1097.1 6897.4 6959.0 6994.8 7005.8 7029.6 7677.1 7688.6 7705.9 7709.3 7732.3 6967.0 6974.9 6977.2 6980.1 6987.3 4014.7 4029.5 4065.2 4077.6 4080.2 8184.3 8221.0 8221.8 8261.0 8267.9 8094.9 8094.9 8095.4 8098.9 8142.9 8219.2 8235.9 8240.3 8243.4 8246.8 6379.6 7533.6 7756.5 7797.6 7823.8 7613.0 7621.1 7622.4 7623.1 7627.0 8172.1 8185.7 8203.2 8214.7 8234.9 4214.4 4763.2 4811.5 4815.6 4836.2 7449.5 7498.1 7623.6 7762.0 7800.7 7396.7 7400.8 7445.7 7451.5 7454.6 7428.1 7437.6 7439.7 7444.5 7484.7 7242.4 7277.0 7289.5 7290.5 7335.8 5744.5 7437.2 7446.6 7451.3 7499.9 5852.0 7273.9 7274.2 7286.6 7304.2 09:29:12 INFO - PROCESS | 1670 | 09:29:12 INFO - PROCESS | 1670 | [#5] yui.html Cycles:180 Average:18199.66 Median:586.67 stddev:25553.13 (4355.6%) stddev-sans-first:25591.26 09:29:12 INFO - PROCESS | 1670 | Values: 757.7 764.0 773.8 787.9 788.1 15160.6 15183.0 15293.2 15333.4 15364.5 12318.9 14265.1 14271.3 14286.7 14291.4 610.2 786.6 959.7 974.2 974.6 952.8 965.4 966.7 966.8 969.2 999.7 1012.7 1016.7 1017.5 1017.6 841.3 880.4 988.4 1005.4 1020.3 744.5 751.6 771.1 772.3 774.9 15224.4 15475.3 15493.3 15507.8 15523.3 10945.4 12793.3 12845.2 12959.0 13143.3 10048.4 10162.4 10199.4 10310.4 10314.5 3008.4 3489.5 3535.7 3620.1 3717.3 80345.0 80995.0 82082.6 82395.6 82984.6 9300.2 9464.7 9615.6 9732.9 9759.8 21254.9 21316.8 21335.6 21360.9 21407.5 7577.6 7581.2 7648.6 7675.5 7737.8 4147.5 4164.8 4200.1 4215.0 4222.3 3755.8 3794.7 3803.2 3813.9 3875.3 683.6 690.7 692.1 698.2 699.4 495.8 581.8 604.4 616.2 621.4 6738.8 8329.7 8454.2 8547.9 8581.8 535.0 591.5 599.1 631.1 631.8 3296.5 3874.5 3918.0 3929.5 4001.5 92604.6 93340.0 93624.0 95170.5 99717.0 77364.6 79521.2 79709.6 79761.6 81031.6 49548.5 55064.7 67936.7 69599.0 72597.3 8413.9 8575.4 8696.0 8764.9 8775.6 46259.0 47775.8 48707.8 49026.5 49205.0 64443.7 65701.3 66192.0 66220.0 66311.0 10777.8 10855.4 11176.7 11277.5 11509.5 11938.6 11998.6 12357.0 12366.0 12527.2 11358.8 11418.5 11479.7 11526.7 11984.0 9882.9 10894.9 11653.1 11859.3 11921.7 11223.6 11295.2 11320.6 11415.3 11766.8 9708.6 9726.0 9778.1 9847.6 10023.8 9458.9 9609.6 9628.3 9630.9 9777.0 09:29:12 INFO - PROCESS | 1670 | -------- Summary: end -------- 09:29:12 INFO - PROCESS | 1670 | 09:29:13 INFO - TEST-INFO | 1670: exit 0 09:29:13 INFO - TEST-OK | dromaeo_css | took 1110746ms 09:29:13 INFO - TEST-START | kraken 09:29:13 INFO - operating with platform_type : mac_ 09:29:13 INFO - Initialising browser for kraken test... 09:29:13 INFO - TEST-INFO | started process 1682 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpl1FQ66/profile http://localhost:49272/getInfo.html) 09:29:16 INFO - PROCESS | 1682 | __metrics Screen width/height:1600/1200 09:29:16 INFO - PROCESS | 1682 | colorDepth:24 09:29:16 INFO - PROCESS | 1682 | Browser inner width/height: 1024/689 09:29:16 INFO - PROCESS | 1682 | __metrics 09:29:16 ERROR - PROCESS | 1682 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2849: TypeError: this.tabs is undefined 09:29:16 INFO - TEST-INFO | 1682: exit 0 09:29:16 INFO - Browser initialized. 09:29:16 INFO - Running cycle 1/1 for kraken test... 09:29:16 INFO - TEST-INFO | started process 1686 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/76/zc2kqpz548q1by6kbrt7871800000w/T/tmpl1FQ66/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:29:28 INFO - PROCESS | 1686 | RSS: Main: 219168768 09:29:28 INFO - PROCESS | 1686 | 09:29:31 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection) 09:29:32 INFO - PROCESS | 1686 | RSS: Main: 231190528 09:29:32 INFO - PROCESS | 1686 | 09:29:35 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-dft) 09:29:35 INFO - PROCESS | 1686 | RSS: Main: 241119232 09:29:35 INFO - PROCESS | 1686 | 09:29:39 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-fft) 09:29:39 INFO - PROCESS | 1686 | RSS: Main: 244453376 09:29:39 INFO - PROCESS | 1686 | 09:29:41 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator) 09:29:42 INFO - PROCESS | 1686 | RSS: Main: 245915648 09:29:42 INFO - PROCESS | 1686 | 09:29:44 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:29:44 INFO - PROCESS | 1686 | RSS: Main: 246235136 09:29:44 INFO - PROCESS | 1686 | 09:29:47 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom) 09:29:48 INFO - PROCESS | 1686 | RSS: Main: 247123968 09:29:48 INFO - PROCESS | 1686 | 09:29:51 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate) 09:29:52 INFO - PROCESS | 1686 | RSS: Main: 246935552 09:29:52 INFO - PROCESS | 1686 | 09:29:54 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial) 09:29:55 INFO - PROCESS | 1686 | RSS: Main: 247545856 09:29:55 INFO - PROCESS | 1686 | 09:29:57 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:29:57 INFO - PROCESS | 1686 | RSS: Main: 246431744 09:29:57 INFO - PROCESS | 1686 | 09:29:59 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:30:00 INFO - PROCESS | 1686 | RSS: Main: 246845440 09:30:00 INFO - PROCESS | 1686 | 09:30:02 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:30:03 INFO - PROCESS | 1686 | RSS: Main: 247230464 09:30:03 INFO - PROCESS | 1686 | 09:30:05 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:30:06 INFO - PROCESS | 1686 | RSS: Main: 246190080 09:30:06 INFO - PROCESS | 1686 | 09:30:08 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:30:09 INFO - PROCESS | 1686 | RSS: Main: 247472128 09:30:09 INFO - PROCESS | 1686 | 09:30:11 INFO - PROCESS | 1686 | Cycle 1(1): loaded http://localhost:49272/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49272/tests/kraken/driver.html?testName=ai-astar) 09:30:11 INFO - PROCESS | 1686 | RSS: Main: 248745984 09:30:11 INFO - PROCESS | 1686 | 09:30:11 INFO - PROCESS | 1686 | __start_tp_report 09:30:11 INFO - PROCESS | 1686 | _x_x_mozilla_page_load 09:30:11 INFO - PROCESS | 1686 | _x_x_mozilla_page_load_details 09:30:11 INFO - PROCESS | 1686 | |i|pagename|runs| 09:30:11 INFO - PROCESS | 1686 | |0;ai-astar;131;98;172;93;172;122;171;105;159;156 09:30:11 INFO - PROCESS | 1686 | |1;audio-beat-detection;179;118;185;183;146;141;109;193;182;120 09:30:11 INFO - PROCESS | 1686 | |2;audio-dft;189;192;198;197;193;194;198;198;198;196 09:30:11 INFO - PROCESS | 1686 | |3;audio-fft;67;84;62;116;83;83;85;55;134;89 09:30:11 INFO - PROCESS | 1686 | |4;audio-oscillator;86;84;128;78;81;80;116;77;79;118 09:30:11 INFO - PROCESS | 1686 | |5;imaging-gaussian-blur;88;85;89;85;95;117;89;96;127;104 09:30:11 INFO - PROCESS | 1686 | |6;imaging-darkroom;94;94;94;104;94;93;94;121;96;153 09:30:11 INFO - PROCESS | 1686 | |7;imaging-desaturate;91;94;93;91;96;129;94;152;151;92 09:30:11 INFO - PROCESS | 1686 | |8;json-parse-financial;53;59;61;58;61;60;59;69;68;82 09:30:11 INFO - PROCESS | 1686 | |9;json-stringify-tinderbox;70;106;67;79;76;76;85;99;103;66 09:30:11 INFO - PROCESS | 1686 | |10;stanford-crypto-aes;83;84;83;83;81;80;83;83;84;96 09:30:11 INFO - PROCESS | 1686 | |11;stanford-crypto-ccm;134;133;107;110;145;130;112;138;113;111 09:30:11 INFO - PROCESS | 1686 | |12;stanford-crypto-pbkdf2;135;138;135;143;137;138;140;148;135;134 09:30:11 INFO - PROCESS | 1686 | |13;stanford-crypto-sha256-iterative;62;69;69;63;65;57;89;94;70;65 09:30:11 INFO - PROCESS | 1686 | __end_tp_report 09:30:11 INFO - PROCESS | 1686 | __start_cc_report 09:30:11 INFO - PROCESS | 1686 | _x_x_mozilla_cycle_collect,945 09:30:11 INFO - PROCESS | 1686 | __end_cc_report 09:30:11 INFO - PROCESS | 1686 | __startTimestamp1457371811364__endTimestamp 09:30:11 INFO - PROCESS | 1686 | 09:30:11 INFO - PROCESS | 1686 | ------- Summary: start ------- 09:30:11 INFO - PROCESS | 1686 | Number of tests: 14 09:30:11 INFO - PROCESS | 1686 | 09:30:11 INFO - PROCESS | 1686 | [#0] ai-astar Cycles:10 Average:137.90 Median:171.50 stddev:31.95 (18.6%) stddev-sans-first:33.79 09:30:11 INFO - PROCESS | 1686 | Values: 131.0 98.0 172.0 93.0 172.0 122.0 171.0 105.0 159.0 156.0 09:30:11 INFO - PROCESS | 1686 | 09:30:11 INFO - PROCESS | 1686 | [#1] audio-beat-detection Cycles:10 Average:155.60 Median:180.50 stddev:32.35 (17.9%) stddev-sans-first:33.18 09:30:11 INFO - PROCESS | 1686 | Values: 179.0 118.0 185.0 183.0 146.0 141.0 109.0 193.0 182.0 120.0 09:30:11 INFO - PROCESS | 1686 | 09:30:11 INFO - PROCESS | 1686 | [#2] audio-dft Cycles:10 Average:195.30 Median:197.50 stddev:3.16 (1.6%) stddev-sans-first:2.40 09:30:11 INFO - PROCESS | 1686 | Values: 189.0 192.0 198.0 197.0 193.0 194.0 198.0 198.0 198.0 196.0 09:30:11 INFO - PROCESS | 1686 | 09:30:11 INFO - PROCESS | 1686 | [#3] audio-fft Cycles:10 Average:85.80 Median:83.00 stddev:23.88 (28.8%) stddev-sans-first:24.34 09:30:11 INFO - PROCESS | 1686 | Values: 67.0 84.0 62.0 116.0 83.0 83.0 85.0 55.0 134.0 89.0 09:30:11 INFO - PROCESS | 1686 | 09:30:11 INFO - PROCESS | 1686 | [#4] audio-oscillator Cycles:10 Average:92.70 Median:79.50 stddev:19.71 (24.8%) stddev-sans-first:20.76 09:30:11 INFO - PROCESS | 1686 | Values: 86.0 84.0 128.0 78.0 81.0 80.0 116.0 77.0 79.0 118.0 09:30:11 INFO - PROCESS | 1686 | 09:30:11 INFO - PROCESS | 1686 | [#5] imaging-gaussian-blur Cycles:10 Average:97.50 Median:88.50 stddev:14.33 (16.2%) stddev-sans-first:14.78 09:30:11 INFO - PROCESS | 1686 | Values: 88.0 85.0 89.0 85.0 95.0 117.0 89.0 96.0 127.0 104.0 09:30:11 INFO - PROCESS | 1686 | 09:30:11 INFO - PROCESS | 1686 | [#6] imaging-darkroom Cycles:10 Average:103.70 Median:94.00 stddev:19.36 (20.6%) stddev-sans-first:20.22 09:30:11 INFO - PROCESS | 1686 | Values: 94.0 94.0 94.0 104.0 94.0 93.0 94.0 121.0 96.0 153.0 09:30:11 INFO - PROCESS | 1686 | 09:30:11 INFO - PROCESS | 1686 | [#7] imaging-desaturate Cycles:10 Average:108.30 Median:92.50 stddev:25.43 (27.5%) stddev-sans-first:26.19 09:30:11 INFO - PROCESS | 1686 | Values: 91.0 94.0 93.0 91.0 96.0 129.0 94.0 152.0 151.0 92.0 09:30:11 INFO - PROCESS | 1686 | 09:30:11 INFO - PROCESS | 1686 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:61.00 stddev:8.14 (13.3%) stddev-sans-first:7.79 09:30:11 INFO - PROCESS | 1686 | Values: 53.0 59.0 61.0 58.0 61.0 60.0 59.0 69.0 68.0 82.0 09:30:11 INFO - PROCESS | 1686 | 09:30:11 INFO - PROCESS | 1686 | [#9] json-stringify-tinderbox Cycles:10 Average:82.70 Median:76.00 stddev:14.97 (19.7%) stddev-sans-first:15.15 09:30:11 INFO - PROCESS | 1686 | Values: 70.0 106.0 67.0 79.0 76.0 76.0 85.0 99.0 103.0 66.0 09:30:11 INFO - PROCESS | 1686 | 09:30:11 INFO - PROCESS | 1686 | [#10] stanford-crypto-aes Cycles:10 Average:84.00 Median:83.00 stddev:4.40 (5.3%) stddev-sans-first:4.65 09:30:11 INFO - PROCESS | 1686 | Values: 83.0 84.0 83.0 83.0 81.0 80.0 83.0 83.0 84.0 96.0 09:30:11 INFO - PROCESS | 1686 | 09:30:11 INFO - PROCESS | 1686 | [#11] stanford-crypto-ccm Cycles:10 Average:123.30 Median:131.50 stddev:14.02 (10.7%) stddev-sans-first:14.32 09:30:11 INFO - PROCESS | 1686 | Values: 134.0 133.0 107.0 110.0 145.0 130.0 112.0 138.0 113.0 111.0 09:30:11 INFO - PROCESS | 1686 | 09:30:11 INFO - PROCESS | 1686 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:138.30 Median:138.00 stddev:4.37 (3.2%) stddev-sans-first:4.47 09:30:11 INFO - PROCESS | 1686 | Values: 135.0 138.0 135.0 143.0 137.0 138.0 140.0 148.0 135.0 134.0 09:30:11 INFO - PROCESS | 1686 | 09:30:11 INFO - PROCESS | 1686 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.30 Median:69.00 stddev:11.88 (17.2%) stddev-sans-first:12.21 09:30:11 INFO - PROCESS | 1686 | Values: 62.0 69.0 69.0 63.0 65.0 57.0 89.0 94.0 70.0 65.0 09:30:11 INFO - PROCESS | 1686 | -------- Summary: end -------- 09:30:11 INFO - PROCESS | 1686 | 09:30:12 INFO - TEST-INFO | 1686: exit 0 09:30:12 INFO - TEST-OK | kraken | took 58670ms 09:30:12 INFO - SUITE-END | took 1169s 09:30:12 INFO - Completed test suite (00:19:29) 09:30:12 INFO - javascript benchmark 09:30:12 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3251.382237374899, 3544.32657795019, 3607.368710475666, 3619.891403257903, 3641.1989362340278, 5787.710614469275, 5866.882662346761, 5869.14897339886, 5880.6765627890445, 5886.676232807194, 5834.183214349984, 5880.2355693759855, 5892.9705351473185, 5894.440028197314, 5953.017752070903, 5296.788128474856, 5300.708461034642, 5375.462453754632, 5379.139337705968, 5380.623356365037, 5297.390800058004, 5366.570674346043, 5390.380106287768, 5414.40441551431, 5427.701476418795, 5408.675479471224, 5421.512063914247, 5424.349078110613, 5430.511253987141, 5443.428440013801, 4363.301871700529, 5355.143177091647, 5389.973050134763, 5436.238926550286, 5448.128299472065, 5210.452902445264, 5222.973885130588, 5292.153255479144, 5308.575313974873, 5318.441563635801, 5631.155326700987, 5681.971590142023, 5710.14347847822, 5747.971260143714, 5780.2196703444915, 6181.536384771161, 6242.0, 6298.149749783812, 6305.653189074599, 6306.400891915261, 6238.313785483593, 6290.779822706229, 6293.402126797947, 6308.526860485482, 6312.905306420407, 4879.7804098816, 5877.85305367365, 5926.762929482772, 5968.612040217372, 6013.128096425994, 5651.830445086572, 6168.797084568556, 6239.688015599202, 6369.9681501592195, 6409.359064093646, 6234.470070044006, 6247.875042499216, 6275.0, 6278.215223097113, 6287.1826662534495, 6282.717277722513, 6310.05349197624, 6321.146645202839, 6324.525660575475, 6327.936720632827, 6173.32093469718, 6264.780732674426, 6282.403171698681, 6302.4958003359625, 6303.842403939847, 6210.068489726486, 6253.937460625336, 6262.874742505124, 6278.748850046039, 6287.371262873768, 4973.502649734997, 4976.90046199074, 4988.501149885055, 5002.74986250686, 5009.0, 4323.524412314643, 4371.388005679208, 4446.822127114944, 4457.910841783211, 4517.073999830027, 5851.502622277069, 5953.553483488756, 5954.910676339859, 5995.010823214121, 5998.070299103646, 5362.0, 5788.913166302509, 6276.968615156895, 6291.905621415683, 6317.431431171217, 5834.124881267844, 5953.077273022688, 5965.284165900033, 6009.519238460913, 6051.878962420815, 5482.91775623366, 5494.148406996922, 5497.038018346773, 5509.090999984957, 5524.475174858382, 6510.121133646991, 6543.901841472287, 6549.9345006550275, 6564.901526477202, 6570.5729127606555, 6163.9383606163365, 6225.408586184305, 6255.593386429868, 6295.685215739286, 6307.810765677037, 5158.38099428056, 5370.543503802221, 5534.889302213853, 6533.020046992799, 6539.247986481616, 6256.061590761422, 6293.213348331458, 6298.370162983665, 6303.1175635412, 6308.873822523616, 6213.285472170577, 6257.4681152102585, 6259.874802504016, 6302.558820882494, 6324.7153878076515, 6205.441510263918, 6225.968870155621, 6235.719392627252, 6256.280527739368, 6267.091271765659, 4856.757162141808, 6061.0, 6235.75056997715, 6264.248290205022, 6271.0, 6023.698815059141, 6041.335453100243, 6065.120557519047, 6089.086637004308, 6106.480949119375, 6228.719707613259, 6237.438630523275, 6242.906356404748, 6245.812625621239, 6258.968705156445, 6096.725647345791, 6114.785982490592, 6115.3578874217565, 6129.387061294014, 6154.353792851865], "unit": "score", "name": "dojo.html", "value": 5774.059541451511}, {"lowerIsBetter": false, "replicates": [570.9124118554156, 580.7531798985433, 615.4122812713858, 619.4239357397619, 634.6667999300367, 38692.67843929366, 39282.0, 39331.80334098333, 39431.605683943155, 39589.604103958955, 40689.57586484474, 40769.980750481176, 41163.38254926178, 41240.38139427911, 41301.79349103258, 8909.821803563926, 9461.81076378472, 9653.806923861519, 9660.806783864318, 9661.130498255156, 9541.522923853814, 9822.557984890696, 9847.458389788559, 9853.521971704266, 9865.112139907407, 8395.95802020989, 9807.460589667566, 9869.95065024674, 9908.405495670248, 9910.55402506889, 9727.319087663866, 9834.360766550151, 9840.55717492711, 9845.90154098457, 9868.901310986907, 9613.807723845553, 9708.61165553377, 9735.26985476085, 9743.853842192373, 9769.853452198222, 40259.39610905839, 40489.78530644056, 40505.98735031618, 40588.39117413241, 40619.0, 3261.673832616743, 3361.6638336166434, 3432.8970130896114, 3462.6537346265422, 3723.2553489301977, 28432.28919277014, 29268.853655731797, 29292.974745884007, 29549.40901181986, 29632.70367296321, 2589.1714651311586, 2700.257429206964, 2786.7352601502826, 2822.5483922572494, 2935.6917523660136, 449188.0, 451701.0, 452278.0, 452755.73622132005, 453609.0, 47254.0, 47635.0, 70989.0, 71624.0, 71673.28326716665, 46632.0, 46973.825654358916, 47023.29465058027, 47032.5296747035, 47209.5279047212, 16384.0169589825, 16530.58673533171, 16535.421260255833, 16599.0, 16645.7515686324, 13151.473941042443, 13167.53913613019, 13222.933885330513, 13254.337283135805, 13255.138416003121, 13465.990050746233, 14916.477923272634, 15229.390824366901, 15564.377424903103, 15771.369145234292, 5954.672493012839, 6341.175647165839, 6754.493412994045, 6913.516053876281, 6928.688209030605, 981.7005813226891, 1055.4300677634146, 1056.1761825775907, 1074.5540055166387, 1167.8189880568525, 24763.876180618983, 27895.72104278972, 29792.404151917275, 29949.401011980073, 30593.38813223723, 907.9364444488822, 1105.1435137768133, 1162.91859569831, 1167.2121318110242, 1231.3664982704165, 14554.781678274834, 14557.272136393138, 14695.41218351254, 14815.70368592622, 14838.925805370904, 525727.0, 528274.0, 529921.0, 535757.6424235707, 536633.0, 61894.0, 62208.0, 62268.37731622716, 62498.0, 62526.0621090684, 1511.3954418232795, 1525.8855585831107, 1543.53693891832, 1549.775282584019, 1565.1078885035647, 28379.00673476501, 28451.857740711162, 28689.0, 28911.855440722662, 29064.0, 51486.74256628693, 51555.0, 51676.0, 51794.741026296135, 52036.73981630067, 508615.0, 509516.0, 509657.0, 512635.0, 513404.0, 33238.833805830815, 34426.31147377088, 35189.76835810734, 35255.29489410146, 35276.82361588176, 45866.770666146454, 46022.84942876455, 46134.0, 47512.812179695786, 48360.27459588179, 37892.263467066616, 37982.43026354552, 38372.808135959145, 38406.65576704802, 38629.03427414225, 35690.92927212188, 37819.43270850994, 37927.24145517129, 38386.42420363753, 38657.806710966266, 32560.837195814816, 37352.0, 37726.43410348902, 37971.81014094912, 38892.61107389003, 29847.798767229997, 31409.685903140675, 31452.842735786173, 31581.0, 31612.525812113297, 20299.28952486656, 24149.637755434032, 24458.89934952967, 24685.62971555392, 24791.76041197969], "unit": "score", "name": "ext.html", "value": 19588.905645985662}, {"lowerIsBetter": false, "replicates": [346.57717584546845, 359.11657322985445, 378.25483796920076, 388.9377699568069, 390.3715018819702, 15468.226588670565, 20182.293619723314, 20977.056032478537, 20995.160193592237, 21020.054097565608, 12281.201721888094, 12407.751844963095, 12453.813192802092, 12456.875431245684, 12465.750684986317, 5296.417394086657, 5489.560835133199, 5650.632708873931, 6099.9085013724825, 6105.755769769204, 5895.380984996578, 5910.0, 5973.820785376446, 5991.041433370661, 6006.909896351558, 5637.689927054011, 5817.272840894888, 5889.528837692974, 5900.144479050535, 5916.911246331309, 5539.377531805221, 5784.13238014297, 5800.303963524362, 5841.269841269841, 5986.790462333841, 5819.301683797971, 5819.883602327972, 5831.037878750001, 5831.096180092092, 5831.766729330821, 12797.0, 12881.806772898413, 19954.0, 23966.400839978967, 24095.638565421534, 2109.430453777487, 2116.153538584563, 2384.892679829412, 2784.5127102756937, 2848.4872722909868, 9858.507074646312, 9974.601015959353, 10002.499875006293, 10322.690319290434, 10421.218408619385, 1791.8566514678926, 1823.1157888424104, 1855.5082903030707, 1864.4127099963468, 1865.8880467172014, 108698.0, 110728.0, 113189.43405283004, 116723.0, 118455.0, 11932.0, 11973.46119424628, 12052.156349055482, 12086.214396064228, 12144.332061736513, 11690.0, 11781.823272650918, 12051.337176455203, 12772.680682982815, 14647.340869660891, 6871.931280687129, 7962.686156784182, 9053.637854485747, 9103.954480227556, 9168.037356077515, 9253.72238832836, 9278.814423711623, 9280.767980800534, 9287.978322384532, 9389.765255868659, 4587.977060114678, 4618.1918164321105, 4663.556962088596, 4665.4634717007975, 4674.555917187861, 1969.4879331373945, 2031.14691829432, 2031.6749320109006, 2065.1429656692303, 2084.4997200672033, 869.517417833096, 921.4701546610592, 971.946542940145, 973.5667627905514, 1065.824139017069, 18244.361447349278, 19814.60370792605, 20093.598128037356, 20246.0, 20731.585368292548, 926.6895589977298, 951.6383774165911, 979.5347210075299, 1005.3465247589126, 1029.6190409548515, 10765.569377224823, 10930.070943969693, 10976.012158905736, 10985.780284394268, 10996.12031037515, 650214.0, 653172.0, 658515.0, 670131.0, 671386.0, 97744.51127744316, 102318.0, 110179.44910275398, 113214.0, 113375.0, 972.6304004478394, 988.728099772554, 1003.372891942536, 1005.4570531912832, 1006.0, 17523.386681466596, 17681.91159044248, 17813.643727125644, 18224.635507289513, 18313.908430457763, 51181.48818511916, 52199.0, 53909.0, 54625.72687136539, 55996.440035599124, 61791.0, 73124.26875731387, 73254.26745732687, 73493.69278382379, 77022.0, 11257.605983790529, 11605.477753500943, 11781.0, 11950.163488555718, 12024.398780060787, 13827.585172444842, 13842.100263482842, 13853.722925541231, 14155.575332740034, 14191.361388737325, 11569.942150289195, 11818.46816893259, 11992.700182495508, 12101.636950891487, 12120.454579544117, 11696.590619328283, 11931.284122952651, 12056.336901470153, 12226.0, 12863.356832158543, 8266.669333226604, 11534.077273818242, 12165.0, 12237.326947017644, 12459.563915262923, 9307.627694892399, 9383.812323753624, 10157.593696252066, 10754.677359679223, 12362.0, 12140.514379424723, 12171.39143042862, 12294.20087694297, 12321.630351089481, 12350.81473777876], "unit": "score", "name": "jquery.html", "value": 9597.361864148226}, {"lowerIsBetter": false, "replicates": [1597.369039229504, 1666.5083800278917, 1670.6909221793974, 1773.67187070392, 1955.8044195580435, 8204.138565450616, 8785.692500762474, 8946.194842464178, 9191.954040229797, 9244.722658320252, 8990.0, 9003.684871029514, 9085.364024518287, 9097.13577210164, 9098.090190980898, 2127.6276651585986, 2525.88633511492, 2541.1106112860443, 2541.2884392370074, 2542.034027069711, 2454.7054353477606, 2540.0220914947695, 2544.2367289812983, 2551.068859866154, 2554.0549996501322, 2522.255934499327, 2540.0347867810206, 2576.407426291954, 2580.6129080637866, 2581.4966081613998, 2119.5760847830343, 2528.9620655690087, 2540.733223011576, 2542.2627438042946, 2559.5904655255163, 2526.7473252674768, 2528.9494210115877, 2532.2403279016407, 2538.936526586832, 2579.8968041278326, 7461.328480436787, 8325.125861784485, 9082.500462474562, 9180.632774689071, 9196.954015229881, 5513.365962914276, 5643.6049476536655, 5686.744096515626, 5717.171010203539, 5767.711614419304, 3523.6300188480095, 3525.008370270789, 3552.769070010441, 3642.1805093853936, 3688.465172549992, 1031.6389263757699, 1044.8276034454307, 1045.3466583385384, 1048.8531605575226, 1050.03921411908, 12241.449134788867, 12379.690507737288, 12413.317267550281, 12421.565245216465, 12495.25028498293, 4539.0694907543875, 4956.083124621957, 5031.748412579356, 5063.696178229318, 5068.6451948364, 9813.754656133653, 10438.0, 10528.0, 10529.473526323653, 10533.315334503233, 5617.887642247132, 5631.605787594911, 5642.802501912413, 5642.971785141131, 5686.317641883001, 4508.571685689854, 4982.3522942018035, 5058.570021548136, 5064.037832811754, 5135.589152867761, 4013.57857424972, 4070.430139780433, 4088.8773336799945, 4111.8972025698995, 4119.279126152911, 1357.7895426208954, 1362.8500864904852, 1367.9726405471836, 1373.8282714660668, 1377.5936098850664, 1357.457017193111, 1400.5308221745624, 1406.177386229047, 1409.9002777833307, 1415.7027024325007, 8383.455075420079, 8445.662173513114, 8504.744857654281, 8505.362097842686, 8512.829743405096, 531.4093792760293, 540.8188256933971, 542.4521233554138, 542.7421974562052, 544.7848100000557, 6192.845178870474, 6247.5939063960695, 6297.338779428185, 6308.463780578611, 6335.176427064452, 10790.730231744112, 11181.888181118247, 11195.552177912792, 11232.606858759904, 11279.154063445274, 10703.571857125628, 11030.834537481944, 11038.392888391216, 11081.445927703744, 11306.0, 8640.524771137521, 8699.43453675509, 8731.694390696295, 8777.29781617469, 8781.912180878237, 7931.801704957422, 8086.070101938352, 8095.39284553649, 8138.145494723206, 8146.674133034612, 9664.420134791935, 9986.001399859955, 9994.300398972002, 10006.14947729422, 10092.0, 10190.745231369276, 10384.0, 10386.221033422373, 10416.0, 10591.523381448007, 7378.114626244885, 7562.962185189039, 7611.0, 7617.047869016373, 7757.1079325878245, 8393.202645748644, 8399.664013439395, 8425.410221284452, 8446.282066024456, 8473.57632118404, 7357.705691772269, 7500.099988001475, 7587.734429294948, 7605.771826845204, 7723.961380193063, 7412.888806667796, 7468.029156209658, 7518.398528117847, 7579.962100189464, 7605.885911711218, 6531.575447595891, 7339.229380914927, 7871.527708337518, 7938.3252423544645, 7940.0, 7083.468739844429, 7154.998300237867, 7170.677319520739, 7178.712851485882, 7196.172440169447, 7165.283471652793, 7186.7125314986815, 7187.712491500281, 7205.207427183111, 7239.746608868664], "unit": "score", "name": "mootools.html", "value": 4981.498554541982}, {"lowerIsBetter": false, "replicates": [336.9241920567872, 340.3754111205937, 342.4315636044164, 347.2014366956001, 348.3729287282891, 6874.793756187316, 6911.377975982161, 6921.134858142732, 6929.514933954612, 6954.547954382968, 5510.283663123799, 6873.690683919223, 6899.551529150602, 6949.235584085746, 6956.860862782742, 4882.707037577739, 4987.226979818134, 5110.28456016158, 5118.129917913963, 5133.307003554528, 3915.5105611798526, 5093.224192814906, 5097.108006098936, 5108.335916330871, 5160.509751573594, 4173.895652608694, 5013.548780609744, 5089.923651145235, 5116.846494605168, 5117.974410127963, 4195.601417865298, 5055.241713742931, 5114.156164232897, 5126.589872810204, 5135.589152867761, 4368.978155109236, 4388.605025547684, 4396.1867054595, 4396.296592545209, 4397.516273209944, 5548.278723765925, 6321.494280457552, 6642.66786660665, 6673.499487538405, 6746.966265168692, 5495.395506494282, 5825.679587622679, 5873.500752436048, 5929.6145750526075, 5954.821355359346, 5917.615355001911, 7380.0, 7405.666744996488, 7407.074115735533, 7438.590877501735, 4326.134773045404, 4733.408323959505, 4735.337052812609, 4735.455422626407, 4754.429468463806, 5779.422057794229, 5915.3493115757665, 6855.5886646801355, 7786.610669466504, 7890.8816367754525, 4266.33871749873, 4509.346144808985, 4703.435587729495, 4823.782929768169, 4847.878803029953, 4913.852584422473, 4920.458749537548, 4920.72935988524, 4929.285253638202, 4936.03747269279, 5873.765049398062, 5899.823005309848, 5904.3210030847, 5920.5559583031445, 5921.911171332434, 5658.688772117573, 7453.888191677129, 7464.253574642492, 7493.66278517468, 7498.550086994798, 1510.2146883620455, 1517.521980576115, 1603.510929166592, 1659.2035822805121, 1682.6634673065191, 1068.8663917010374, 1085.5386460754148, 1089.9727506812235, 1092.9617463388743, 1097.1277834121893, 6897.41371983377, 6958.956156576554, 6994.825129371807, 7005.824854378681, 7029.648517574101, 7677.078750549858, 7688.577128257888, 7705.9229407706325, 7709.344705699966, 7732.265434783687, 6967.024616553686, 6974.895376569356, 6977.232504424509, 6980.080477868525, 6987.26633703464, 4014.7189696720948, 4029.4560234368573, 4065.2072845794787, 4077.5922407758985, 4080.224757296104, 8184.263416292562, 8220.958895205486, 8221.780119367737, 8261.0, 8267.875981860278, 8094.878576821352, 8094.919050809416, 8095.433319667567, 8098.878516822252, 8142.918570814334, 8219.178082191733, 8235.917640823634, 8240.258376746002, 8243.422960392714, 8246.793830154294, 6379.585326953733, 7533.623318834146, 7756.534607923542, 7797.649105790139, 7823.84352312962, 7613.010308659839, 7621.085469743666, 7622.390208783395, 7623.085229772463, 7626.9618651906385, 8172.101068882537, 8185.672573097248, 8203.179682031749, 8214.740946239594, 8234.876476852973, 4214.4310518079665, 4763.190257656276, 4811.518848115161, 4815.566599006106, 4836.202026665561, 7449.478536502393, 7498.137714162723, 7623.618819059136, 7762.029746281715, 7800.726974555863, 7396.667149978156, 7400.777976660709, 7445.739399121005, 7451.478396512192, 7454.552726836408, 7428.1086269647985, 7437.590932498764, 7439.665215065227, 7444.516106453063, 7484.738034168778, 7242.3843973262865, 7277.0, 7289.5261807982315, 7290.4896657233485, 7335.77992660221, 5744.540436765133, 7437.219091995263, 7446.553206807609, 7451.254874512505, 7499.887501687588, 5851.970740146442, 7273.927260727325, 7274.199838017708, 7286.599237041802, 7304.160021597584], "unit": "score", "name": "prototype.html", "value": 5345.208830307943}, {"lowerIsBetter": false, "replicates": [757.7499425189686, 763.9618019099044, 773.7872085176575, 787.8778789287662, 788.1409263902345, 15160.620984475394, 15183.0, 15293.235338233071, 15333.386664533433, 15364.462243821468, 12318.876811231885, 14265.1440913545, 14271.286435678201, 14286.714265714705, 14291.428342866273, 610.2341561340522, 786.5949036246309, 959.6689142245914, 974.1573538888881, 974.5663179884954, 952.8046750416148, 965.4448692002092, 966.7244835221964, 966.7824739433642, 969.1568335548083, 999.7350702063959, 1012.7215015870657, 1016.6899095775785, 1017.5471914997829, 1017.64382466137, 841.2554888923316, 880.3573391424233, 988.4365911430488, 1005.3615953869272, 1020.285799940045, 744.4714252880461, 751.5528260684883, 771.0824119298018, 772.2740623813653, 774.9263819937097, 15224.391024359013, 15475.303611337516, 15493.302801373966, 15507.844921550866, 15523.3014514346, 10945.398003109825, 12793.296368699717, 12845.229286242762, 12959.0, 13143.27711975841, 10048.397096174253, 10162.39025658463, 10199.368101103863, 10310.432926189056, 10314.535845886952, 3008.3983203359417, 3489.5289135966573, 3535.699465545406, 3620.1311685195365, 3717.3494638438165, 80345.0, 80995.0, 82082.58958705228, 82395.5880220595, 82984.58507707484, 9300.162985331353, 9464.668736594185, 9615.615375385047, 9732.902670973199, 9759.804803903882, 21254.893725531274, 21316.78683213148, 21335.573288534142, 21360.893195534234, 21407.46481337979, 7577.583232922242, 7581.166071732105, 7648.579328136894, 7675.5010924289745, 7737.806554836062, 4147.52303485097, 4164.7709375984, 4200.1179752252365, 4215.009472773896, 4222.303319952173, 3755.830987605564, 3794.6774524165753, 3803.220339830328, 3813.9427908581392, 3875.2636998970106, 683.586430209716, 690.7271627707028, 692.1037256752518, 698.1517456290632, 699.4474365251394, 495.7546014722735, 581.8429024163452, 604.4106995679177, 616.1774031667684, 621.3910367839543, 6738.764143255061, 8329.6668133274, 8454.239118479367, 8547.871781923277, 8581.785455363666, 534.9572034237252, 591.4913174669781, 599.1312596734753, 631.0817760158958, 631.7757196195284, 3296.4725643896863, 3874.4575759393706, 3918.0, 3929.4891664084057, 4001.4790681870236, 92604.61093083609, 93340.0, 93624.0, 95170.52414737882, 99717.0, 77364.61317693375, 79521.20478795253, 79709.60145199353, 79761.60119199367, 81031.59484202541, 49548.50451495511, 55064.72467637636, 67936.6603166981, 69599.0, 72597.27402726011, 8413.915860841313, 8575.442596231225, 8695.956520217358, 8764.912350876664, 8775.56122193875, 46259.0, 47775.76112119417, 48707.75646121747, 49026.50973490362, 49205.0, 64443.67778161079, 65701.34298656952, 66192.0, 66220.0, 66311.0, 10777.784444311226, 10855.40295283767, 11176.72058198519, 11277.492512837107, 11509.482073306554, 11938.64184074479, 11998.580049698568, 12357.0, 12366.0, 12527.18573292733, 11358.792007809132, 11418.543258269576, 11479.713007174887, 11526.654200374001, 11984.04127669767, 9882.901170988198, 10894.891051089704, 11653.067754579444, 11859.288442693465, 11921.701957451132, 11223.60717374888, 11295.152863535432, 11320.60377886803, 11415.315081095161, 11766.764664706829, 9708.563114659715, 9726.0, 9778.145431350798, 9847.556859941176, 10023.849642255225, 9458.905410946078, 9609.615615375307, 9628.32601717873, 9630.855537167088, 9777.0], "unit": "score", "name": "yui.html", "value": 6996.779345655808}], "name": "dromaeo_css", "value": 7661.548075324884}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [131.0, 98.0, 172.0, 93.0, 172.0, 122.0, 171.0, 105.0, 159.0, 156.0], "unit": "score", "name": "ai-astar", "value": 137.9}, {"lowerIsBetter": true, "replicates": [179.0, 118.0, 185.0, 183.0, 146.0, 141.0, 109.0, 193.0, 182.0, 120.0], "unit": "score", "name": "audio-beat-detection", "value": 155.6}, {"lowerIsBetter": true, "replicates": [189.0, 192.0, 198.0, 197.0, 193.0, 194.0, 198.0, 198.0, 198.0, 196.0], "unit": "score", "name": "audio-dft", "value": 195.3}, {"lowerIsBetter": true, "replicates": [67.0, 84.0, 62.0, 116.0, 83.0, 83.0, 85.0, 55.0, 134.0, 89.0], "unit": "score", "name": "audio-fft", "value": 85.8}, {"lowerIsBetter": true, "replicates": [86.0, 84.0, 128.0, 78.0, 81.0, 80.0, 116.0, 77.0, 79.0, 118.0], "unit": "score", "name": "audio-oscillator", "value": 92.7}, {"lowerIsBetter": true, "replicates": [88.0, 85.0, 89.0, 85.0, 95.0, 117.0, 89.0, 96.0, 127.0, 104.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 97.5}, {"lowerIsBetter": true, "replicates": [94.0, 94.0, 94.0, 104.0, 94.0, 93.0, 94.0, 121.0, 96.0, 153.0], "unit": "score", "name": "imaging-darkroom", "value": 103.7}, {"lowerIsBetter": true, "replicates": [91.0, 94.0, 93.0, 91.0, 96.0, 129.0, 94.0, 152.0, 151.0, 92.0], "unit": "score", "name": "imaging-desaturate", "value": 108.3}, {"lowerIsBetter": true, "replicates": [53.0, 59.0, 61.0, 58.0, 61.0, 60.0, 59.0, 69.0, 68.0, 82.0], "unit": "score", "name": "json-parse-financial", "value": 63.0}, {"lowerIsBetter": true, "replicates": [70.0, 106.0, 67.0, 79.0, 76.0, 76.0, 85.0, 99.0, 103.0, 66.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 82.7}, {"lowerIsBetter": true, "replicates": [83.0, 84.0, 83.0, 83.0, 81.0, 80.0, 83.0, 83.0, 84.0, 96.0], "unit": "score", "name": "stanford-crypto-aes", "value": 84.0}, {"lowerIsBetter": true, "replicates": [134.0, 133.0, 107.0, 110.0, 145.0, 130.0, 112.0, 138.0, 113.0, 111.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 123.3}, {"lowerIsBetter": true, "replicates": [135.0, 138.0, 135.0, 143.0, 137.0, 138.0, 140.0, 148.0, 135.0, 134.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 138.3}, {"lowerIsBetter": true, "replicates": [62.0, 69.0, 69.0, 63.0, 65.0, 57.0, 89.0, 94.0, 70.0, 65.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 70.3}], "name": "kraken", "value": 1538.4}]} 09:30:12 INFO - Return code: 0 09:30:12 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 09:30:12 ERROR - # TBPL SUCCESS # 09:30:12 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:30:12 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:30:12 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:30:12 INFO - 2016-03-07 09:30:12.665 screenresolution[1692:10708] starting screenresolution argv=screenresolution get 09:30:12 INFO - 2016-03-07 09:30:12.667 screenresolution[1692:10708] Display 0: 1600x1200x32@60 09:30:12 INFO - 2016-03-07 09:30:12.673 screenresolution[1693:10711] starting screenresolution argv=screenresolution list 09:30:12 INFO - Available Modes on Display 0 09:30:12 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:30:12 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:30:12 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:30:12 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:30:12 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:30:12 INFO - Intel Iris: 09:30:12 INFO - Chipset Model: Intel Iris 09:30:12 INFO - Type: GPU 09:30:12 INFO - Bus: Built-In 09:30:12 INFO - VRAM (Dynamic, Max): 1536 MB 09:30:12 INFO - Vendor: Intel (0x8086) 09:30:12 INFO - Device ID: 0x0a2e 09:30:12 INFO - Revision ID: 0x0009 09:30:12 INFO - Displays: 09:30:12 INFO - Display: 09:30:12 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:30:12 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:30:12 INFO - Display Serial Number: 1600x1200 60 09:30:12 INFO - Main Display: Yes 09:30:12 INFO - Mirror: Off 09:30:12 INFO - Online: Yes 09:30:12 INFO - Rotation: Supported 09:30:12 INFO - Return code: 0 09:30:12 INFO - Running post-action listener: _resource_record_post_action 09:30:12 INFO - Running post-run listener: _resource_record_post_run 09:30:13 INFO - Total resource usage - Wall time: 1204s; CPU: 53.0%; Read bytes: 37258752; Write bytes: 666531328; Read time: 434; Write time: 1826 09:30:13 INFO - install - Wall time: 33s; CPU: 54.0%; Read bytes: 355801600; Write bytes: 352265728; Read time: 28216; Write time: 626 09:30:13 INFO - run-tests - Wall time: 1172s; CPU: 53.0%; Read bytes: 35493376; Write bytes: 303095808; Read time: 415; Write time: 1172 09:30:13 INFO - Running post-run listener: _upload_blobber_files 09:30:13 INFO - Blob upload gear active. 09:30:13 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:30:13 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 09:30:13 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', 'Mozilla-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:30:13 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 Mozilla-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:30:14 INFO - (blobuploader) - INFO - Open directory for files ... 09:30:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 09:30:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:30:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 09:30:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:30:15 INFO - (blobuploader) - INFO - Done attempting. 09:30:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 09:30:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:30:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:30:16 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 09:30:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:30:16 INFO - (blobuploader) - INFO - Done attempting. 09:30:16 INFO - (blobuploader) - INFO - Iteration through files over. 09:30:16 INFO - Return code: 0 09:30:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:30:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:30:16 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5c8a21cb5da4baa35e900545572bc6601e0c8479e38926f8521a4af6a4478107052a56a9473e8fae7c72a879040bd414a9c775f44e4fb8e00f3ec23194c0afd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47bd0c73a65f08d91b68bda15a855e0176cc71c226bd8e61110a4fcd26ef1de93d9b62ead922fe6f3ee81f3458b1266dd13b66ccc96cde77321dba0c2fd25e98"} 09:30:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:30:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:30:16 INFO - Contents: 09:30:16 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5c8a21cb5da4baa35e900545572bc6601e0c8479e38926f8521a4af6a4478107052a56a9473e8fae7c72a879040bd414a9c775f44e4fb8e00f3ec23194c0afd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47bd0c73a65f08d91b68bda15a855e0176cc71c226bd8e61110a4fcd26ef1de93d9b62ead922fe6f3ee81f3458b1266dd13b66ccc96cde77321dba0c2fd25e98"} 09:30:16 INFO - Running post-run listener: copy_logs_to_upload_dir 09:30:16 INFO - Copying logs to upload dir... 09:30:16 INFO - mkdir: /builds/slave/test/build/upload/logs 09:30:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1274.925922 ========= master_lag: 0.15 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 15 secs) (at 2016-03-07 09:30:16.212094) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 09:30:16.215258) ========= 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.DyfHGqgQTw/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.41cBG8sqXz/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5c8a21cb5da4baa35e900545572bc6601e0c8479e38926f8521a4af6a4478107052a56a9473e8fae7c72a879040bd414a9c775f44e4fb8e00f3ec23194c0afd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47bd0c73a65f08d91b68bda15a855e0176cc71c226bd8e61110a4fcd26ef1de93d9b62ead922fe6f3ee81f3458b1266dd13b66ccc96cde77321dba0c2fd25e98"} build_url:https://queue.taskcluster.net/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010749 build_url: 'https://queue.taskcluster.net/v1/task/Yxgkud2OSt2YAMJLs3JFqg/artifacts/public/build/firefox-47.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/f5c8a21cb5da4baa35e900545572bc6601e0c8479e38926f8521a4af6a4478107052a56a9473e8fae7c72a879040bd414a9c775f44e4fb8e00f3ec23194c0afd", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/47bd0c73a65f08d91b68bda15a855e0176cc71c226bd8e61110a4fcd26ef1de93d9b62ead922fe6f3ee81f3458b1266dd13b66ccc96cde77321dba0c2fd25e98"}' ========= master_lag: 0.70 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-03-07 09:30:16.926065) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 9 secs) (at 2016-03-07 09:30:16.926352) ========= 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.DyfHGqgQTw/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.41cBG8sqXz/Listeners TMPDIR=/var/folders/76/zc2kqpz548q1by6kbrt7871800000w/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.005138 ========= master_lag: 9.54 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 9 secs) (at 2016-03-07 09:30:26.468854) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 09:30:26.469213) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-03-07 09:30:26.684421) ========= ========= Total master_lag: 12.55 =========