builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0091 starttime: 1455800275.84 results: success (0) buildid: 20160218025826 builduid: fc0cb643eed340f4a4b87b4faf1e758b revision: 3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:55.844092) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:55.844613) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:55.844959) ========= 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.MR0RRcPvFW/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.WmtgVpk4ly/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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.006083 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:55.868521) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:55.868847) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:55.884234) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:55.884576) ========= 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.MR0RRcPvFW/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.WmtgVpk4ly/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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.005529 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:55.936376) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:55.937117) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:55.937643) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:55.937988) ========= 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.MR0RRcPvFW/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.WmtgVpk4ly/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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-02-18 04:57:55-- 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% 6.90M=0.002s 2016-02-18 04:57:56 (6.90 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.167386 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:56.120518) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:56.120874) ========= 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.MR0RRcPvFW/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.WmtgVpk4ly/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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.019331 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:56.170626) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 04:57:56.171028) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MR0RRcPvFW/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.WmtgVpk4ly/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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-02-18 04:57:56,235 truncating revision to first 12 chars 2016-02-18 04:57:56,235 Setting DEBUG logging. 2016-02-18 04:57:56,236 attempt 1/10 2016-02-18 04:57:56,236 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/3b35f0a98eba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-18 04:57:57,700 unpacking tar archive at: mozilla-central-3b35f0a98eba/testing/mozharness/ program finished with exit code 0 elapsedTime=1.757011 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-18 04:57:57.945639) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:57.946047) ========= echo 3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MR0RRcPvFW/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.WmtgVpk4ly/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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 3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb program finished with exit code 0 elapsedTime=0.005201 script_repo_revision: '3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:57.997816) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:57.998210) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-18 04:57:58.011358) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-18 04:57:58.011761) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.MR0RRcPvFW/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.WmtgVpk4ly/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:57:58 INFO - MultiFileLogger online at 20160218 04:57:58 in /builds/slave/test 04:57:58 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:57:58 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:57:58 INFO - {'append_to_log': False, 04:57:58 INFO - 'base_work_dir': '/builds/slave/test', 04:57:58 INFO - 'blob_upload_branch': 'Firefox', 04:57:58 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:57:58 INFO - 'branch': 'Firefox', 04:57:58 INFO - 'buildbot_json_path': 'buildprops.json', 04:57:58 INFO - 'config_files': ('talos/mac_config.py',), 04:57:58 INFO - 'default_actions': ('clobber', 04:57:58 INFO - 'read-buildbot-config', 04:57:58 INFO - 'download-and-extract', 04:57:58 INFO - 'populate-webroot', 04:57:58 INFO - 'create-virtualenv', 04:57:58 INFO - 'install', 04:57:58 INFO - 'run-tests'), 04:57:58 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:57:58 INFO - 'download_minidump_stackwalk': True, 04:57:58 INFO - 'download_symbols': 'ondemand', 04:57:58 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:57:58 INFO - 'tooltool.py': '/tools/tooltool.py', 04:57:58 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:57:58 INFO - '/tools/misc-python/virtualenv.py')}, 04:57:58 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:57:58 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:57:58 INFO - 'installer_path': 'installer.exe', 04:57:58 INFO - 'log_level': 'info', 04:57:58 INFO - 'log_name': 'talos', 04:57:58 INFO - 'log_to_console': True, 04:57:58 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:57:58 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:57:58 INFO - 'opt_config_files': (), 04:57:58 INFO - 'pip_index': False, 04:57:58 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:57:58 INFO - 'cmd': ('bash', 04:57:58 INFO - '-c', 04:57:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:57:58 INFO - 'enabled': True, 04:57:58 INFO - 'halt_on_failure': False, 04:57:58 INFO - 'name': 'check_screen_resolution'},), 04:57:58 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:57:58 INFO - 'cmd': ('bash', 04:57:58 INFO - '-c', 04:57:58 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:57:58 INFO - 'enabled': True, 04:57:58 INFO - 'halt_on_failure': False, 04:57:58 INFO - 'name': 'check_screen_resolution'},), 04:57:58 INFO - 'run_cmd_checks_enabled': True, 04:57:58 INFO - 'sps_profile': False, 04:57:58 INFO - 'sps_profile_interval': 0, 04:57:58 INFO - 'suite': 'dromaeojs-e10s', 04:57:58 INFO - 'system_bits': '32', 04:57:58 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:57:58 INFO - 'title': 't-yosemite-r7-0091', 04:57:58 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:57:58 INFO - 'use_talos_json': True, 04:57:58 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:57:58 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:57:58 INFO - 'work_dir': 'build'} 04:57:58 INFO - ##### 04:57:58 INFO - ##### Running clobber step. 04:57:58 INFO - ##### 04:57:58 INFO - Running pre-action listener: _resource_record_pre_action 04:57:58 INFO - Running main action method: clobber 04:57:58 INFO - rmtree: /builds/slave/test/build 04:57:58 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:58:00 INFO - Running post-action listener: _resource_record_post_action 04:58:00 INFO - ##### 04:58:00 INFO - ##### Running read-buildbot-config step. 04:58:00 INFO - ##### 04:58:00 INFO - Running pre-action listener: _resource_record_pre_action 04:58:00 INFO - Running main action method: read_buildbot_config 04:58:00 INFO - Using buildbot properties: 04:58:00 INFO - { 04:58:00 INFO - "project": "", 04:58:00 INFO - "product": "firefox", 04:58:00 INFO - "script_repo_revision": "production", 04:58:00 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 04:58:00 INFO - "repository": "", 04:58:00 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 04:58:00 INFO - "buildid": "20160218025826", 04:58:00 INFO - "pgo_build": "False", 04:58:00 INFO - "basedir": "/builds/slave/test", 04:58:00 INFO - "buildnumber": 173, 04:58:00 INFO - "slavename": "t-yosemite-r7-0091", 04:58:00 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 04:58:00 INFO - "platform": "yosemite_r7", 04:58:00 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:58:00 INFO - "branch": "mozilla-central", 04:58:00 INFO - "repo_path": "mozilla-central", 04:58:00 INFO - "revision": "3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb", 04:58:00 INFO - "stage_platform": "macosx64", 04:58:00 INFO - "builduid": "fc0cb643eed340f4a4b87b4faf1e758b", 04:58:00 INFO - "slavebuilddir": "test" 04:58:00 INFO - } 04:58:00 INFO - Found installer url https://queue.taskcluster.net/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 04:58:00 INFO - Running post-action listener: _resource_record_post_action 04:58:00 INFO - ##### 04:58:00 INFO - ##### Running download-and-extract step. 04:58:00 INFO - ##### 04:58:00 INFO - Running pre-action listener: _resource_record_pre_action 04:58:00 INFO - Running main action method: download_and_extract 04:58:00 INFO - mkdir: /builds/slave/test/build/tests 04:58:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:00 INFO - https://queue.taskcluster.net/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 04:58:00 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/test_packages.json 04:58:00 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/test_packages.json 04:58:00 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 04:58:00 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 04:58:01 INFO - Downloaded 1277 bytes. 04:58:01 INFO - Reading from file /builds/slave/test/build/test_packages.json 04:58:01 INFO - Using the following test package requirements: 04:58:01 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:58:01 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:58:01 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 04:58:01 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:58:01 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 04:58:01 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:58:01 INFO - u'jsshell-mac.zip'], 04:58:01 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:58:01 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 04:58:01 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:58:01 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:58:01 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 04:58:01 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:58:01 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 04:58:01 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:58:01 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 04:58:01 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 04:58:01 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 04:58:01 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 04:58:01 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:58:01 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:01 INFO - https://queue.taskcluster.net/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:58:01 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:58:01 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:58:01 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:58:01 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:58:02 INFO - Downloaded 17806546 bytes. 04:58:02 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:58:02 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:58:05 INFO - Return code: 0 04:58:05 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip', u'firefox-47.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:58:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:05 INFO - https://queue.taskcluster.net/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:58:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:58:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:58:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip 04:58:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:58:06 INFO - Downloaded 17806546 bytes. 04:58:06 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:58:06 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:58:10 INFO - Return code: 0 04:58:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:10 INFO - https://queue.taskcluster.net/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:58:10 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:58:10 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:58:10 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip 04:58:10 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:58:11 INFO - Downloaded 10707071 bytes. 04:58:11 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:58:11 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-47.0a1.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:58:11 INFO - Return code: 0 04:58:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:11 INFO - https://queue.taskcluster.net/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 04:58:11 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:58:11 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:58:11 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 04:58:11 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg'}, attempt #1 04:58:14 INFO - Downloaded 111240594 bytes. 04:58:14 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:58:14 INFO - mkdir: /builds/slave/test/properties 04:58:14 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:58:14 INFO - Writing to file /builds/slave/test/properties/build_url 04:58:14 INFO - Contents: 04:58:14 INFO - build_url:https://queue.taskcluster.net/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 04:58:15 INFO - Running post-action listener: _resource_record_post_action 04:58:15 INFO - Running post-action listener: set_extra_try_arguments 04:58:15 INFO - ##### 04:58:15 INFO - ##### Running populate-webroot step. 04:58:15 INFO - ##### 04:58:15 INFO - Running pre-action listener: _resource_record_pre_action 04:58:15 INFO - Running main action method: populate_webroot 04:58:15 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:58:15 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:58:15 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:58:15 INFO - '--tppagecycles', 04:58:15 INFO - '7'], 04:58:15 INFO - 'tests': ['tsvgm']}}, 04:58:15 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 04:58:15 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 04:58:15 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:58:15 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 04:58:15 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 04:58:15 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:58:15 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:58:15 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:15 INFO - 'talos_options': ['--e10s'], 04:58:15 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:58:15 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:15 INFO - 'tests': ['damp', 'tps']}, 04:58:15 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:15 INFO - 'talos_options': ['--e10s'], 04:58:15 INFO - 'tests': ['damp', 'tps']}, 04:58:15 INFO - 'g3': {'tests': ['dromaeo_dom']}, 04:58:15 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:58:15 INFO - 'other': {'tests': ['a11yr', 04:58:15 INFO - 'ts_paint', 04:58:15 INFO - 'tpaint', 04:58:15 INFO - 'sessionrestore', 04:58:15 INFO - 'sessionrestore_no_auto_restore']}, 04:58:15 INFO - 'other-e10s': {'talos_options': ['--e10s'], 04:58:15 INFO - 'tests': ['a11yr', 04:58:15 INFO - 'ts_paint', 04:58:15 INFO - 'tpaint', 04:58:15 INFO - 'sessionrestore', 04:58:15 INFO - 'sessionrestore_no_auto_restore']}, 04:58:15 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 04:58:15 INFO - 'tests': ['a11yr', 04:58:15 INFO - 'ts_paint', 04:58:15 INFO - 'tpaint', 04:58:15 INFO - 'sessionrestore', 04:58:15 INFO - 'sessionrestore_no_auto_restore']}, 04:58:15 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 04:58:15 INFO - 'tests': ['a11yr', 04:58:15 INFO - 'ts_paint', 04:58:15 INFO - 'tpaint', 04:58:15 INFO - 'sessionrestore', 04:58:15 INFO - 'sessionrestore_no_auto_restore']}, 04:58:15 INFO - 'other_l64': {'tests': ['a11yr', 04:58:15 INFO - 'ts_paint', 04:58:15 INFO - 'tpaint', 04:58:15 INFO - 'sessionrestore', 04:58:15 INFO - 'sessionrestore_no_auto_restore']}, 04:58:15 INFO - 'other_nol64': {'tests': ['a11yr', 04:58:15 INFO - 'ts_paint', 04:58:15 INFO - 'tpaint', 04:58:15 INFO - 'sessionrestore', 04:58:15 INFO - 'sessionrestore_no_auto_restore']}, 04:58:15 INFO - 'svgr': {'tests': ['tsvgx', 04:58:15 INFO - 'tsvgr_opacity', 04:58:15 INFO - 'tart', 04:58:15 INFO - 'tscrollx', 04:58:15 INFO - 'cart']}, 04:58:15 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 04:58:15 INFO - 'tests': ['tsvgx', 04:58:15 INFO - 'tsvgr_opacity', 04:58:15 INFO - 'tart', 04:58:15 INFO - 'tscrollx', 04:58:15 INFO - 'cart']}, 04:58:15 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:15 INFO - 'tests': ['tp5o']}, 04:58:15 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:15 INFO - 'talos_options': ['--e10s'], 04:58:15 INFO - 'tests': ['tp5o']}, 04:58:15 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:15 INFO - 'talos_options': ['--xperf_path', 04:58:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:58:15 INFO - 'tests': ['tp5n']}, 04:58:15 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:58:15 INFO - 'talos_options': ['--e10s', 04:58:15 INFO - '--xperf_path', 04:58:15 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:58:15 INFO - 'tests': ['tp5n']}}, 04:58:15 INFO - 'talos.zip': {'path': '', 04:58:15 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:58:15 INFO - Running post-action listener: _resource_record_post_action 04:58:15 INFO - ##### 04:58:15 INFO - ##### Running create-virtualenv step. 04:58:15 INFO - ##### 04:58:15 INFO - Running pre-action listener: _resource_record_pre_action 04:58:15 INFO - Running main action method: create_virtualenv 04:58:15 INFO - Creating virtualenv /builds/slave/test/build/venv 04:58:15 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:58:15 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:58:15 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:58:15 INFO - Using real prefix '/tools/python27' 04:58:15 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:58:16 INFO - Installing distribute.............................................................................................................................................................................................done. 04:58:19 INFO - Installing pip.................done. 04:58:19 INFO - Return code: 0 04:58:19 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:19 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 0x10359aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1325cca40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10343ed30>, '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 0x103262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103435b20>, '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.MR0RRcPvFW/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.WmtgVpk4ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:58:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:58:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MR0RRcPvFW/Render', 04:58:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:19 INFO - 'HOME': '/Users/cltbld', 04:58:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:19 INFO - 'LOGNAME': 'cltbld', 04:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:19 INFO - 'MOZ_NO_REMOTE': '1', 04:58:19 INFO - 'NO_EM_RESTART': '1', 04:58:19 INFO - 'PAGER': '/bin/cat', 04:58:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:19 INFO - 'PWD': '/builds/slave/test', 04:58:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:19 INFO - 'SHELL': '/bin/bash', 04:58:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmtgVpk4ly/Listeners', 04:58:19 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 04:58:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:19 INFO - 'USER': 'cltbld', 04:58:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:19 INFO - 'XPC_FLAGS': '0x0', 04:58:19 INFO - 'XPC_SERVICE_NAME': '0', 04:58:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:19 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:58:19 INFO - Cleaning up... 04:58:19 INFO - Return code: 0 04:58:19 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:19 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 0x10359aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1325cca40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10343ed30>, '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 0x103262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103435b20>, '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.MR0RRcPvFW/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.WmtgVpk4ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:58:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 04:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 04:58:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MR0RRcPvFW/Render', 04:58:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:19 INFO - 'HOME': '/Users/cltbld', 04:58:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:19 INFO - 'LOGNAME': 'cltbld', 04:58:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:19 INFO - 'MOZ_NO_REMOTE': '1', 04:58:19 INFO - 'NO_EM_RESTART': '1', 04:58:19 INFO - 'PAGER': '/bin/cat', 04:58:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:19 INFO - 'PWD': '/builds/slave/test', 04:58:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:19 INFO - 'SHELL': '/bin/bash', 04:58:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmtgVpk4ly/Listeners', 04:58:19 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 04:58:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:19 INFO - 'USER': 'cltbld', 04:58:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:19 INFO - 'XPC_FLAGS': '0x0', 04:58:19 INFO - 'XPC_SERVICE_NAME': '0', 04:58:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:19 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:19 INFO - Downloading/unpacking psutil>=0.7.1 04:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:19 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:19 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:19 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:19 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:22 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:58:22 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:58:22 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:22 INFO - Installing collected packages: psutil 04:58:22 INFO - Running setup.py install for psutil 04:58:22 INFO - building 'psutil._psutil_osx' extension 04:58:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:58:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:58:22 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:58:22 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:58:23 INFO - building 'psutil._psutil_posix' extension 04:58:23 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:58:23 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:58:23 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:58:23 INFO - ^ 04:58:23 INFO - 1 warning generated. 04:58:23 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:58:23 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:58:23 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:58:23 INFO - Successfully installed psutil 04:58:23 INFO - Cleaning up... 04:58:23 INFO - Return code: 0 04:58:23 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:23 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 0x10359aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1325cca40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10343ed30>, '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 0x103262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103435b20>, '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.MR0RRcPvFW/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.WmtgVpk4ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:58:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 04:58:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 04:58:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MR0RRcPvFW/Render', 04:58:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:23 INFO - 'HOME': '/Users/cltbld', 04:58:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:23 INFO - 'LOGNAME': 'cltbld', 04:58:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:23 INFO - 'MOZ_NO_REMOTE': '1', 04:58:23 INFO - 'NO_EM_RESTART': '1', 04:58:23 INFO - 'PAGER': '/bin/cat', 04:58:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:23 INFO - 'PWD': '/builds/slave/test', 04:58:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:23 INFO - 'SHELL': '/bin/bash', 04:58:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmtgVpk4ly/Listeners', 04:58:23 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 04:58:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:23 INFO - 'USER': 'cltbld', 04:58:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:23 INFO - 'XPC_FLAGS': '0x0', 04:58:23 INFO - 'XPC_SERVICE_NAME': '0', 04:58:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:23 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:25 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:58:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:58:26 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:58:26 INFO - Installing collected packages: mozsystemmonitor 04:58:26 INFO - Running setup.py install for mozsystemmonitor 04:58:26 INFO - Successfully installed mozsystemmonitor 04:58:26 INFO - Cleaning up... 04:58:26 INFO - Return code: 0 04:58:26 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10359aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1325cca40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10343ed30>, '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 0x103262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103435b20>, '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.MR0RRcPvFW/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.WmtgVpk4ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:58:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:58:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:58:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MR0RRcPvFW/Render', 04:58:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:26 INFO - 'HOME': '/Users/cltbld', 04:58:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:26 INFO - 'LOGNAME': 'cltbld', 04:58:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:26 INFO - 'MOZ_NO_REMOTE': '1', 04:58:26 INFO - 'NO_EM_RESTART': '1', 04:58:26 INFO - 'PAGER': '/bin/cat', 04:58:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:26 INFO - 'PWD': '/builds/slave/test', 04:58:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:26 INFO - 'SHELL': '/bin/bash', 04:58:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmtgVpk4ly/Listeners', 04:58:26 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 04:58:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:26 INFO - 'USER': 'cltbld', 04:58:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:26 INFO - 'XPC_FLAGS': '0x0', 04:58:26 INFO - 'XPC_SERVICE_NAME': '0', 04:58:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:26 INFO - Downloading/unpacking blobuploader==1.2.4 04:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:28 INFO - Downloading blobuploader-1.2.4.tar.gz 04:58:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:58:28 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:58:29 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:29 INFO - Downloading docopt-0.6.1.tar.gz 04:58:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:58:30 INFO - Installing collected packages: blobuploader, requests, docopt 04:58:30 INFO - Running setup.py install for blobuploader 04:58:30 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:58:30 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:58:30 INFO - Running setup.py install for requests 04:58:30 INFO - Running setup.py install for docopt 04:58:30 INFO - Successfully installed blobuploader requests docopt 04:58:30 INFO - Cleaning up... 04:58:30 INFO - Return code: 0 04:58:30 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:30 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 0x10359aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1325cca40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10343ed30>, '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 0x103262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103435b20>, '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.MR0RRcPvFW/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.WmtgVpk4ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:58:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:58:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:58:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MR0RRcPvFW/Render', 04:58:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:30 INFO - 'HOME': '/Users/cltbld', 04:58:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:30 INFO - 'LOGNAME': 'cltbld', 04:58:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:30 INFO - 'MOZ_NO_REMOTE': '1', 04:58:30 INFO - 'NO_EM_RESTART': '1', 04:58:30 INFO - 'PAGER': '/bin/cat', 04:58:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:30 INFO - 'PWD': '/builds/slave/test', 04:58:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:30 INFO - 'SHELL': '/bin/bash', 04:58:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmtgVpk4ly/Listeners', 04:58:30 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 04:58:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:30 INFO - 'USER': 'cltbld', 04:58:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:30 INFO - 'XPC_FLAGS': '0x0', 04:58:30 INFO - 'XPC_SERVICE_NAME': '0', 04:58:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:58:31 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-sHZInv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:58:31 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-RKEfmu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:58:31 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-eGutTq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:58:31 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-ID1gmv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:58:31 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-yWjdHp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:58:31 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-voRVlM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:58:31 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-rCikjf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:58:31 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-PovdLu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:58:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:58:31 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-FTcxLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:58:32 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-OGqJ7W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:58:32 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-uZpJLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:58:32 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-ZEVxkt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:58:32 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-4_FblD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:58:32 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-GEcWRH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:32 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-vsn7Ng-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:58:32 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-g6sB8m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:58:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:58:32 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-JroXzl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:58:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:58:32 INFO - Running setup.py install for manifestparser 04:58:33 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:58:33 INFO - Running setup.py install for mozcrash 04:58:33 INFO - Running setup.py install for mozdebug 04:58:33 INFO - Running setup.py install for mozdevice 04:58:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:58:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:58:33 INFO - Running setup.py install for mozfile 04:58:33 INFO - Running setup.py install for mozhttpd 04:58:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:58:33 INFO - Running setup.py install for mozinfo 04:58:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:58:33 INFO - Running setup.py install for mozInstall 04:58:34 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:58:34 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:58:34 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:58:34 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:58:34 INFO - Running setup.py install for mozleak 04:58:34 INFO - Running setup.py install for mozlog 04:58:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:58:34 INFO - Running setup.py install for moznetwork 04:58:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:58:34 INFO - Running setup.py install for mozprocess 04:58:34 INFO - Running setup.py install for mozprofile 04:58:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:58:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:58:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:58:34 INFO - Running setup.py install for mozrunner 04:58:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:58:35 INFO - Running setup.py install for mozscreenshot 04:58:35 INFO - Running setup.py install for moztest 04:58:35 INFO - Running setup.py install for mozversion 04:58:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:58:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:58:35 INFO - Cleaning up... 04:58:35 INFO - Return code: 0 04:58:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:35 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 0x10359aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1325cca40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10343ed30>, '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 0x103262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103435b20>, '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.MR0RRcPvFW/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.WmtgVpk4ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:58:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:58:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:58:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MR0RRcPvFW/Render', 04:58:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:35 INFO - 'HOME': '/Users/cltbld', 04:58:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:35 INFO - 'LOGNAME': 'cltbld', 04:58:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:35 INFO - 'MOZ_NO_REMOTE': '1', 04:58:35 INFO - 'NO_EM_RESTART': '1', 04:58:35 INFO - 'PAGER': '/bin/cat', 04:58:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:35 INFO - 'PWD': '/builds/slave/test', 04:58:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:35 INFO - 'SHELL': '/bin/bash', 04:58:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmtgVpk4ly/Listeners', 04:58:35 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 04:58:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:35 INFO - 'USER': 'cltbld', 04:58:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:35 INFO - 'XPC_FLAGS': '0x0', 04:58:35 INFO - 'XPC_SERVICE_NAME': '0', 04:58:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:35 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:58:35 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-MW_PZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:58:35 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:58:35 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-rAO8HR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:58:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:58:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:58:35 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-FeJmoQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:58:36 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-xdfMzz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:58:36 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-AB24rN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:58:36 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-g23kDm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:58:36 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-vNyCVT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:58:36 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-RAcCY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:58:36 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-AKesYm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:58:36 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-ZKErsb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:58:36 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-4UFTxd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:58:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:58:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:58:36 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-2_9X9q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:58:37 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-I8owhh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:58:37 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-Y_2MAe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:37 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-lF72zi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:58:37 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-kKKCCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:58:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:58:37 INFO - Running setup.py (path:/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/pip-seMFSD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:58:37 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:58:37 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.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:58:37 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:39 INFO - Downloading blessings-1.6.tar.gz 04:58:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:58:39 INFO - Installing collected packages: blessings 04:58:39 INFO - Running setup.py install for blessings 04:58:40 INFO - Successfully installed blessings 04:58:40 INFO - Cleaning up... 04:58:40 INFO - Return code: 0 04:58:40 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:58:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:58:40 INFO - Reading from file tmpfile_stdout 04:58:40 INFO - Current package versions: 04:58:40 INFO - blessings == 1.6 04:58:40 INFO - blobuploader == 1.2.4 04:58:40 INFO - docopt == 0.6.1 04:58:40 INFO - manifestparser == 1.1 04:58:40 INFO - mozInstall == 1.12 04:58:40 INFO - mozcrash == 0.16 04:58:40 INFO - mozdebug == 0.1 04:58:40 INFO - mozdevice == 0.48 04:58:40 INFO - mozfile == 1.2 04:58:40 INFO - mozhttpd == 0.7 04:58:40 INFO - mozinfo == 0.9 04:58:40 INFO - mozleak == 0.1 04:58:40 INFO - mozlog == 3.1 04:58:40 INFO - moznetwork == 0.27 04:58:40 INFO - mozprocess == 0.22 04:58:40 INFO - mozprofile == 0.28 04:58:40 INFO - mozrunner == 6.11 04:58:40 INFO - mozscreenshot == 0.1 04:58:40 INFO - mozsystemmonitor == 0.0 04:58:40 INFO - moztest == 0.7 04:58:40 INFO - mozversion == 1.4 04:58:40 INFO - psutil == 3.1.1 04:58:40 INFO - requests == 1.2.3 04:58:40 INFO - wsgiref == 0.1.2 04:58:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:40 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 0x10359aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1325cca40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10343ed30>, '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 0x103262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103435b20>, '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.MR0RRcPvFW/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.WmtgVpk4ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:58:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:58:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MR0RRcPvFW/Render', 04:58:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:40 INFO - 'HOME': '/Users/cltbld', 04:58:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:40 INFO - 'LOGNAME': 'cltbld', 04:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:40 INFO - 'MOZ_NO_REMOTE': '1', 04:58:40 INFO - 'NO_EM_RESTART': '1', 04:58:40 INFO - 'PAGER': '/bin/cat', 04:58:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:40 INFO - 'PWD': '/builds/slave/test', 04:58:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:40 INFO - 'SHELL': '/bin/bash', 04:58:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmtgVpk4ly/Listeners', 04:58:40 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 04:58:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:40 INFO - 'USER': 'cltbld', 04:58:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:40 INFO - 'XPC_FLAGS': '0x0', 04:58:40 INFO - 'XPC_SERVICE_NAME': '0', 04:58:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:58:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:58:40 INFO - Cleaning up... 04:58:40 INFO - Return code: 0 04:58:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:40 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 0x10359aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1325cca40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10343ed30>, '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 0x103262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103435b20>, '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.MR0RRcPvFW/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.WmtgVpk4ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:58:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:58:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:58:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MR0RRcPvFW/Render', 04:58:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:40 INFO - 'HOME': '/Users/cltbld', 04:58:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:40 INFO - 'LOGNAME': 'cltbld', 04:58:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:40 INFO - 'MOZ_NO_REMOTE': '1', 04:58:40 INFO - 'NO_EM_RESTART': '1', 04:58:40 INFO - 'PAGER': '/bin/cat', 04:58:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:40 INFO - 'PWD': '/builds/slave/test', 04:58:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:40 INFO - 'SHELL': '/bin/bash', 04:58:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmtgVpk4ly/Listeners', 04:58:40 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 04:58:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:40 INFO - 'USER': 'cltbld', 04:58:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:40 INFO - 'XPC_FLAGS': '0x0', 04:58:40 INFO - 'XPC_SERVICE_NAME': '0', 04:58:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:41 INFO - Downloading/unpacking jsonschema 04:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:41 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:41 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:41 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:43 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:58:43 INFO - Downloading/unpacking functools32 (from jsonschema) 04:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:43 INFO - Downloading functools32-3.2.3-2.tar.gz 04:58:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:58:43 INFO - warning: no files found matching '*.txt' 04:58:43 INFO - no previously-included directories found matching 'build' 04:58:43 INFO - no previously-included directories found matching 'dist' 04:58:43 INFO - no previously-included directories found matching '.git*' 04:58:43 INFO - Installing collected packages: jsonschema, functools32 04:58:43 INFO - Running setup.py install for functools32 04:58:44 INFO - warning: no files found matching '*.txt' 04:58:44 INFO - no previously-included directories found matching 'build' 04:58:44 INFO - no previously-included directories found matching 'dist' 04:58:44 INFO - no previously-included directories found matching '.git*' 04:58:44 INFO - Successfully installed jsonschema functools32 04:58:44 INFO - Cleaning up... 04:58:44 INFO - Return code: 0 04:58:44 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:58:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:58:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:58:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:58:44 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 0x10359aa30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1035a14c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb1325cca40>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10343ed30>, '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 0x103262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103435b20>, '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.MR0RRcPvFW/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.WmtgVpk4ly/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:58:44 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 04:58:44 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 04:58:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MR0RRcPvFW/Render', 04:58:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:58:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:58:44 INFO - 'HOME': '/Users/cltbld', 04:58:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:58:44 INFO - 'LOGNAME': 'cltbld', 04:58:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:58:44 INFO - 'MOZ_NO_REMOTE': '1', 04:58:44 INFO - 'NO_EM_RESTART': '1', 04:58:44 INFO - 'PAGER': '/bin/cat', 04:58:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:58:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:58:44 INFO - 'PWD': '/builds/slave/test', 04:58:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:58:44 INFO - 'SHELL': '/bin/bash', 04:58:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmtgVpk4ly/Listeners', 04:58:44 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 04:58:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:58:44 INFO - 'USER': 'cltbld', 04:58:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:58:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:58:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:58:44 INFO - 'XPC_FLAGS': '0x0', 04:58:44 INFO - 'XPC_SERVICE_NAME': '0', 04:58:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:58:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:58:44 INFO - Downloading/unpacking flake8 04:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:46 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:58:46 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:46 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:46 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:46 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:47 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:58:47 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:47 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:58:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:58:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:58:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:58:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:58:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:58:47 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:58:47 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:58:47 INFO - no previously-included directories found matching 'docs/_build' 04:58:47 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:58:48 INFO - Running setup.py install for pep8 04:58:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:58:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:58:48 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:58:48 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:58:48 INFO - no previously-included directories found matching 'docs/_build' 04:58:48 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:58:48 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:58:48 INFO - Cleaning up... 04:58:48 INFO - Return code: 0 04:58:48 INFO - Running post-action listener: _resource_record_post_action 04:58:48 INFO - Running post-action listener: _start_resource_monitoring 04:58:48 INFO - Starting resource monitoring. 04:58:48 INFO - ##### 04:58:48 INFO - ##### Running install step. 04:58:48 INFO - ##### 04:58:48 INFO - Running pre-action listener: _resource_record_pre_action 04:58:48 INFO - Running main action method: install 04:58:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:58:48 INFO - Reading from file tmpfile_stdout 04:58:48 INFO - Detecting whether we're running mozinstall >=1.0... 04:58:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:58:48 INFO - Reading from file tmpfile_stdout 04:58:48 INFO - Output received: 04:58:48 INFO - Usage: mozinstall [options] installer 04:58:48 INFO - Options: 04:58:48 INFO - -h, --help show this help message and exit 04:58:48 INFO - -d DEST, --destination=DEST 04:58:48 INFO - Directory to install application into. [default: 04:58:48 INFO - "/builds/slave/test"] 04:58:48 INFO - --app=APP Application being installed. [default: firefox] 04:58:48 INFO - mkdir: /builds/slave/test/build/application 04:58:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:58:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:59:22 INFO - Reading from file tmpfile_stdout 04:59:22 INFO - Output received: 04:59:22 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:59:22 INFO - Running post-action listener: _resource_record_post_action 04:59:22 INFO - ##### 04:59:22 INFO - ##### Running run-tests step. 04:59:22 INFO - ##### 04:59:22 INFO - Running pre-action listener: _resource_record_pre_action 04:59:22 INFO - Running main action method: run_tests 04:59:22 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:59:22 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:59:22 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:59:22 INFO - 2016-02-18 04:59:22.665 screenresolution[1965:17190] starting screenresolution argv=screenresolution get 04:59:22 INFO - 2016-02-18 04:59:22.668 screenresolution[1965:17190] Display 0: 1600x1200x32@60 04:59:22 INFO - 2016-02-18 04:59:22.674 screenresolution[1966:17193] starting screenresolution argv=screenresolution list 04:59:22 INFO - Available Modes on Display 0 04:59:22 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:59:22 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:59:22 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:59:22 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:59:22 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:59:22 INFO - Intel Iris: 04:59:22 INFO - Chipset Model: Intel Iris 04:59:22 INFO - Type: GPU 04:59:22 INFO - Bus: Built-In 04:59:22 INFO - VRAM (Dynamic, Max): 1536 MB 04:59:22 INFO - Vendor: Intel (0x8086) 04:59:22 INFO - Device ID: 0x0a2e 04:59:22 INFO - Revision ID: 0x0009 04:59:22 INFO - Displays: 04:59:22 INFO - Display: 04:59:22 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:59:22 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:59:22 INFO - Display Serial Number: 1600x1200 60 04:59:22 INFO - Main Display: Yes 04:59:22 INFO - Mirror: Off 04:59:22 INFO - Online: Yes 04:59:22 INFO - Rotation: Supported 04:59:22 INFO - Return code: 0 04:59:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:59:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:59:22 INFO - Python 2.7.3 04:59:22 INFO - Return code: 0 04:59:22 INFO - grabbing minidump binary from tooltool 04:59:22 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:59:22 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 0x10343ed30>, '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 0x103262db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103435b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:59:22 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:59:22 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:59:22 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:59:22 INFO - Return code: 0 04:59:22 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:59:22 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:59:22 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:59:22 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:59:22 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:59:22 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:59:22 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:59:24 INFO - Return code: 0 04:59:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0091', '--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 04:59:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0091 --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 04:59:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.MR0RRcPvFW/Render', 04:59:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:59:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:59:24 INFO - 'HOME': '/Users/cltbld', 04:59:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:59:24 INFO - 'LOGNAME': 'cltbld', 04:59:24 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:59:24 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:59:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:59:24 INFO - 'MOZ_NO_REMOTE': '1', 04:59:24 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:59:24 INFO - 'NO_EM_RESTART': '1', 04:59:24 INFO - 'PAGER': '/bin/cat', 04:59:24 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:59:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:59:24 INFO - 'PWD': '/builds/slave/test', 04:59:24 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:59:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:59:24 INFO - 'SHELL': '/bin/bash', 04:59:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.WmtgVpk4ly/Listeners', 04:59:24 INFO - 'TMPDIR': '/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/', 04:59:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:59:24 INFO - 'USER': 'cltbld', 04:59:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:59:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:59:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:59:24 INFO - 'XPC_FLAGS': '0x0', 04:59:24 INFO - 'XPC_SERVICE_NAME': '0', 04:59:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:59:24 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0091', '--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 04:59:24 INFO - mozversion application_buildid: 20160218025826 04:59:24 INFO - mozversion application_changeset: 3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb 04:59:24 INFO - mozversion application_display_name: Nightly 04:59:24 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:59:24 INFO - mozversion application_name: Firefox 04:59:24 INFO - mozversion application_remotingname: firefox 04:59:24 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:59:24 INFO - mozversion application_vendor: Mozilla 04:59:24 INFO - mozversion application_version: 47.0a1 04:59:24 INFO - mozversion platform_buildid: 20160218025826 04:59:24 INFO - mozversion platform_changeset: 3b35f0a98eba9f1c9be7d793650b3d5bec6c8fdb 04:59:24 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:59:24 INFO - mozversion platform_version: 47.0a1 04:59:24 INFO - using testdate: 1455800364 04:59:24 INFO - actual date: 1455800364 04:59:24 INFO - starting webserver on 'localhost:56104' 04:59:24 INFO - SUITE-START | Running 2 tests 04:59:24 INFO - TEST-START | dromaeo_css 04:59:24 INFO - operating with platform_type : mac_ 04:59:24 INFO - Initialising browser for dromaeo_css test... 04:59:24 INFO - TEST-INFO | started process 1984 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/tmpswFEKI/profile http://localhost:56104/getInfo.html) 04:59:27 INFO - PROCESS | 1984 | __metrics Screen width/height:1600/1200 04:59:27 INFO - PROCESS | 1984 | colorDepth:24 04:59:27 INFO - PROCESS | 1984 | Browser inner width/height: 1024/689 04:59:27 INFO - PROCESS | 1984 | __metrics 04:59:27 ERROR - PROCESS | 1984 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 04:59:27 INFO - TEST-INFO | 1984: exit 0 04:59:27 INFO - Browser initialized. 04:59:27 INFO - Running cycle 1/1 for dromaeo_css test... 04:59:27 INFO - TEST-INFO | started process 1988 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/tmpswFEKI/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:59:40 INFO - PROCESS | 1988 | RSS: Main: 256696320 04:59:40 INFO - PROCESS | 1988 | 05:00:29 INFO - PROCESS | 1988 | 1455800429860 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] 05:02:40 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:56104/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56104/tests/dromaeo/cssquery-ext.html) 05:02:42 INFO - PROCESS | 1988 | RSS: Main: 270966784 05:02:42 INFO - PROCESS | 1988 | 05:05:44 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:56104/tests/dromaeo/cssquery-ext.html (next: http://localhost:56104/tests/dromaeo/cssquery-jquery.html) 05:05:44 INFO - PROCESS | 1988 | RSS: Main: 282841088 05:05:44 INFO - PROCESS | 1988 | 05:08:46 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:56104/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56104/tests/dromaeo/cssquery-mootools.html) 05:08:47 INFO - PROCESS | 1988 | RSS: Main: 284270592 05:08:47 INFO - PROCESS | 1988 | 05:11:48 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:56104/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56104/tests/dromaeo/cssquery-prototype.html) 05:11:49 INFO - PROCESS | 1988 | RSS: Main: 286294016 05:11:49 INFO - PROCESS | 1988 | 05:14:51 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:56104/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56104/tests/dromaeo/cssquery-yui.html) 05:14:52 INFO - PROCESS | 1988 | RSS: Main: 287809536 05:14:52 INFO - PROCESS | 1988 | 05:17:54 INFO - PROCESS | 1988 | Cycle 1(1): loaded http://localhost:56104/tests/dromaeo/cssquery-yui.html (next: http://localhost:56104/tests/dromaeo/cssquery-dojo.html) 05:17:55 INFO - PROCESS | 1988 | RSS: Main: 290824192 05:17:55 INFO - PROCESS | 1988 | 05:17:55 INFO - PROCESS | 1988 | __start_tp_report 05:17:55 INFO - PROCESS | 1988 | _x_x_mozilla_page_load 05:17:55 INFO - PROCESS | 1988 | _x_x_mozilla_page_load_details 05:17:55 INFO - PROCESS | 1988 | |i|pagename|runs| 05:17:55 INFO - PROCESS | 1988 | |0;dojo.html;3215.64627890932;3527.276908233811;3568.3041806847673;3594.604593494717;3599.8740044098463;5859.648421094732;5864.970675146624;5934.673592952386;5935.436133567309;5943.197668314776;5186.196139598359;5745.2818397700285;5845.970770146154;5931;6092.390760923905;5248.088757219977;5259.9474005259935;5314.388845282803;5355.758990845402;5370.543503802162;5392.272043274166;5402.8919421611545;5403.8108666196695;5404.135338345865;5433.402325744185;4819;4904.558589726924;5313.362396512404;5318.175682769177;5338.145896656536;5284.101702710548;5288.68267903927;5314.468553144693;5316.043112239795;5326.573874090063;5203.167493201107;5241.9213711794355;5268.578513718893;5312.814051508179;5338.466153384669;5742.626729262584;5748.16651585522;5776.046952252916;5785.247917770663;5846.736896839652;6184.134221209034;6230.937690623126;6232.470240029603;6233.283172435137;6249.812505624793;6149.907751383733;6228.844278893019;6267.561270711052;6281.497480201573;6289.622622642611;5139.306193663845;5747.741351639186;5981.461668449861;5988.04191329394;6004.4595986361;6393;6393.552451328363;6393.872122557523;6400.519961002943;6407.519436042222;6106.794380079898;6173.475254603409;6248.28144763349;6255.374462553708;6261.5616906816995;6255.6872156392;6260.812175634738;6265.749370025148;6307;6310.873782524415;6177.96911015442;6181.227346581677;6252.374762523711;6259.624422534663;6267.6866156691985;6225.533085018642;6228.6574238416415;6236.095766113888;6236.158118654014;6251.843703907348;4277.679174061957;4806.831760888352;4961.6526843121355;4961.801527938842;4999.5500404963;4384.7369157850635;4435.844745433894;4464.196444639996;4483.730976141442;4535.931961020588;5911.438413350725;6002.219711437485;6003.969980150158;6004.789832355847;6022.939770602238;4798.568128868418;6282.371762823681;6287.402696743802;6305.054241863665;6322.241331040213;6008.218931538872;6034.939650603438;6050.273967123885;6062.575619706667;6101.786437474667;5460.071787796084;5470.91793623096;5483.095289277305;5521.668699878021;5531.3915469298345;6033.879322413527;6308.148399966038;6403.807885763435;6465.321141280097;6468.191476065492;6217.906731398942;6268.341824108403;6272.968635156795;6276.905846412216;6280.780172693934;6486.99451585005;6497.310699218143;6500.772472963424;6505.772297969548;6527;5791.855203619774;5851.093080572518;6154.076888466766;6251.312355640966;6260.874782504234;5226.817061402832;6242.3133455320785;6259.6870156492905;6268.561200716089;6272.655003974825;6134.6625935573975;6135.263289243823;6196.380361963767;6246.281677606951;6250.9062364065485;6192.535559832941;6217.813465596039;6218.378162183926;6224.564280500322;6238;5472.50747432733;6045.274567051982;6164.660943648142;6170.907436388368;6179.938200617937;6101.489633126266;6129.8784197560135;6213.9067913980425;6219.160413344141;6225.159603453476;6116.66358350295;6137.232845894263;6163.630182189083;6170.568060235741;6183.628982261079 05:17:55 INFO - PROCESS | 1988 | |1;ext.html;445.27420304903023;455.1170728786155;490.2254437987979;553.798257780616;591.645012992205;29962.550561741566;37711.81144094282;37955;38095.42856857143;38096;39595.0101247469;39804;40162.39756403656;40238.99402514938;40644.796776016075;9512.23902087833;9702.272329575275;9733.464659443727;9784;9786.608535658565;9530.380525265835;9790.461524616143;9847.60609575616;9847.606095756197;9856;9765.755856103584;9772.951135244313;9856.704298871009;9863.654772082979;9890;9745.02549745027;9765.12113909748;9827.213822894151;9858.556364963593;9867.11195992364;9701.51492425383;9844;9864.112229899343;9874.061964113398;9902.504874756305;32197.51703724446;38134.61865381366;38954.80522597397;38965.80517097425;39379.8031009846;2788.916332510028;3177.2851108500636;3252.47960326349;3374.6119196292493;3413.9829300853335;26914.5962810558;27300.31749206286;27731.445371092464;27832.582511262346;28288.15135545937;2745.3685652299882;2785.777137828969;2826.3499395139233;2892.47935371633;2966.1546459259225;363800;364737;365558;366320;366321;55878.72060639671;65646.34353656498;66846;66952.6652366735;66953.66523167353;63975.68012159909;64112.67943660345;64650;64794.352056478834;64819;16136.193190340437;16432.507024789276;16455.917720411322;16517.752233716263;16605.750913736305;10553.366797991992;12602.49590016389;12631.557895473614;12825.486980520862;13150.408231629408;17611.207495662726;21268.78731212699;21301.573968520544;21568.56862862734;21592.56814863694;7278.272172782679;7601.923980760122;8447.536510030857;8682.6526938923;8719.956400218085;861.7027125641644;943.7970836270235;973.6932866147141;1099;1186.0867132308074;29435.264118397212;29679.85160074229;29719.40561188764;30223.79104835826;30261.394772104435;1066.4720963123305;1113.0817075912405;1166.9649910502699;1238.6593686736219;1257.7358754661623;16123.11322877253;16160.75758863618;16240.918795405947;16423.67152656964;16480.84634075627;567358;577084;578469;580318;583333;59252.70373648104;59489.70255148697;59703;59868.70065649731;59934.10098848521;1415.6602415420225;1418.6595217148017;1435.7559214933488;1441.9134851908918;1453.0772959171002;30336.938207162642;30601.08196754101;30619;31026.224344391572;31161.688383116787;51716;51964.740176298874;52281;52296;52362;368184.1590792029;438672;439138;534141;536198;31259;32454.513182302755;33225.833870831455;33226.169345766546;33361.66638333683;41720.79139604283;41812.58187418087;42071;42197.578024219365;42683.786581066895;31077.844610776803;32878.1780455481;34353.484697730055;35373.292534148655;35832.64167358293;34769.826150869085;35746;36264;36283.45574816433;36528.81735591305;36218.09454763652;36412.089697757765;36578.45132322964;36722.63277367192;36805.44791828178;30559.08322750321;32247.35505289928;32629.510557342135;32630;32678.50982235316;24610.261692149263;24759.87620061888;24761.876190618932;25096.12163574339;25149 05:17:55 INFO - PROCESS | 1988 | |2;jquery.html;358.541067433685;362.6409854244298;365.73484223937646;367.8050633164424;368.58718235576157;15552.009861668246;19186.328478503256;19277.51806204844;19610.509737256558;20328.288509902173;11507.482163302651;11645.369648249252;11674.299542027484;12302.384880755948;18650.974196419193;3967.444557761916;5128.384593848734;5150.8712282193055;5421.512063914247;5441.102218134003;5692.373838877741;6003.57974941752;6011.5190784737115;6015.187949626788;6027.156198132265;5940.04959206527;6021.09683547467;6535.215774107114;6535.24844642865;6561.442277406426;5445.101558242885;5700.087985922232;6387.680615969206;6462.579932304385;6474.931636280008;4581.785826755912;5183.533481986601;5384.73076346185;5462.617616766828;5467.988422141877;12448.75102497954;12680.23918564889;12726.363681815965;14488.637784055378;23742.169024084247;2159.287435146398;2191.244020812817;2259.706238189025;2530.746925307473;2717.34550735844;9374.625014999392;9414.199793017602;9530.475823829687;9545.856812147824;9891.752706182404;1686.5699246692016;1778.2086971297779;1787.8033416324195;1797.6854050541103;1804.8917064976145;94775.52612236894;98306;98845;99651.50174249083;99860;11202.327860328407;11211.495482703298;11363.204575679623;11390.715232119263;11454.713632159095;11710.355930423908;11896.750841161727;12973.740525189443;12997.700229976926;13395.531156409479;8480;8497.150284971576;8552.871706924401;8557.187067228604;8608.440451370641;7732.30409263169;8019.676753335634;8514;8649.135086491426;8711.651533938571;3798.867039653599;3982.8008599569907;4000.5398029718945;4346.847860324873;4465.665075119379;1851.1854783895044;1891.640588288221;1953.4335042837417;1962.8429725621916;1973.3093417304117;731.4148681055241;736.2403854787063;917.8435171683726;1064.808334499782;1081.8972197641212;17738;18189.45431637053;18710.81289187118;19683.114259858055;20005.799942000685;864.7103220421103;971.5814910231;972.2902281334665;980.8528720691811;1019.2864994503877;10032.097111260022;10277.331973421704;10543.947280263703;10661.200409969284;10774.24580279373;754416;755704;758190;764488;772913.1354343193;90458;105885.41171882428;106282;107370.46314768377;109503.45248273708;1115.4757264085868;1125.2798209146154;1139.4359791903062;1141.1099342512853;1145.699630918913;15234.466793662168;17701.291948321923;17798.37705680295;17893.821061789735;18155.092245387412;32606;47062.52937470582;49915.50084499254;50077.74961125171;50316.496835032645;59705.701471492364;61568.692156540725;70160.94758578727;70558;71401.92897106652;7633.961830190813;7780.572068536058;7796.805079873048;7797.337226335598;7816.6091695416135;9709.36889102206;11818.231814932002;12109.394530273627;12276.202046866925;12385.133040687066;4585.426821647294;8194.34445244367;9900.900990989998;10398.948005259925;10828.24202305831;10036.849447258151;10512.789744205225;10549.89450105489;10799.352038877692;11220.214584978972;8829.955850220707;9546.713598592054;10716.464176790972;11103.5558577656;11256.874312568678;7398.260173982559;7444.627768611656;7700.922990770245;7715.729949451742;7732.226777322223;8122.5126492410645;10522.421266830397;10750.193735470028;10847.566097356017;10861.565537378416 05:17:55 INFO - PROCESS | 1988 | |3;mootools.html;1527.2363818090955;1527.9694406111876;1749.9737503937442;1858.553947052707;1883.80220076892;6902.206246281679;7105.57888422315;7806.219378062191;8481.491110533372;8530.786730331736;8359.749207523784;8395.160483951617;8487.575621218944;8505.617247223874;8512.616932238048;2426.8058555315574;2437.244454219189;2447.9265622031367;2460.2250291158316;2464.7042354917435;2430.5417148323845;2469.4814089041324;2478.4423504711385;2480.466699659573;2483.279848843842;1906.8665193436466;2371.454565449939;2400.1599440195964;2460.963085553718;2463.2117722328862;2199.274239500961;2269.8310370159465;2370.514044620857;2399.172285561487;2402.531506356261;2030.7766145723958;2328.604137296664;2415.613501839715;2424.648425978241;2449.0326321103244;8467.280281176107;8471;8475.237228649452;8519.36104792137;8539.957300213458;5195.68825870449;5288.10102282609;5322.866928326784;5347.438518955492;5367.06076436626;3482.6169121396624;3587.2646107548153;3629.165291982859;3690.4279836625365;3693.686036686858;1063.2504084620325;1075.60708881998;1081.7511972246348;1081.8323159910226;1082.426314053545;11770.293782372999;11796.528138874435;11823.231489953125;11827.526898924032;11850.3482308473;4808.567228949411;4839.9836034433165;4881.8535443936735;4920.138975679313;4925.950740492621;9951.303408761318;10049.899501004897;10063;10067.345622534513;10076.949615251877;5403.540699040547;5412.07994640912;5442;5455.890882182413;5458.754356053987;4855.95144048555;4902.2156454967035;4944.851654450372;4955.430125535538;4975.328330675385;3955.802209889494;3979.8408063677707;3980.7014473914574;3991.560928297885;4025;1304.7455746129413;1307.2222027893388;1309.4500309869686;1327.9136856104321;1331.793571996342;1016.8881423043459;1093.2183488805383;1120.2046546951592;1252.2549083295426;1367.924764137982;7724.459287849797;7812.843743125106;7882.724104656424;7922.920770792333;7929.326007289445;978.8287049766262;1184.6682928779956;1193.8209268609778;1194.5818963362753;1208.3958020989505;6055.636661800306;6098.237720284965;6143.692815359214;6158.538109641705;6198.101275315054;9734.95132524347;10385.428801415843;10472.371657700562;10527.368357898551;10538.473076346152;10212;10265.486725663686;10333.689989300334;10345.482725863676;10401.375917444977;6839.623820689811;8015.358771298283;8040.075391330072;8129.105798362057;8193.385496087818;6492.935070649233;7658.923410765821;7672.769816905502;7702.499337543042;7741.612919354123;8436.662533498591;9055.592498337459;9257.981622021438;9375.531223438664;9397.765055873384;9446.905530944603;9564.90435095668;9565.569549370433;9705.417674939526;9718.805623887341;7275.927240727525;7288.744893928687;7321.12146542397;7322.645310617553;7359.926400735924;6886;7890.013748281465;7920.643571039202;8048.114707382067;8069.5965201740855;5629.352624448077;7528.360089392244;7651.732189373345;7712.807179820549;7737;7346.265373462611;7355.963220183865;7359.742409015659;7406.111266648037;7462.589557574169;7496.700131994659;7539.2083831199125;7564.962175189089;7567.31894129531;7612.961935190288;6816.693248803716;6885;6890.552114112566;6908.274631163656;6917.7232910685025;6940.826479338057;6972.233054363915;7020.438364930896;7050.753223637148;7061.011458395726 05:17:55 INFO - PROCESS | 1988 | |4;prototype.html;282.22388431812516;297.61904761904765;319.3580902386203;326.21707901037524;327.7279857718094;6719.294474080219;6834.931650683492;6857.58854468731;6881.277465866087;6923.619200943953;6759.425448836842;6761.763338283149;6766.560173588713;6767.390934815866;6793.490488213379;4726;4850.223964165734;4969.1800852859415;4981.825636102737;4991.450940396553;4924.236743304794;4950.504949505039;4976.253561965716;4999.675021123633;5000.624953128512;4953.380827396575;4957.281194226835;4967.726775027372;4968.6025117990475;4993.325901003373;4949.406071271453;4953.455119936804;4958.082754690357;4969.602431805465;4986.027724593706;4110.815013324408;4216.704830661855;4225.197212529641;4277.615014648665;4294.699371044028;6468.547201695883;6478.54650174488;6496.610203387764;6509.828230918432;6519.152510173647;5921.348651648358;5923.08192230205;5938.703064846741;5939.881202375971;5947.851303717398;7010.684519196649;7269.673704414589;7284.599347035911;7285.125784905792;7304.415646748301;4793.784279707422;4795.496472870368;4802.4237091548885;4806.086843499724;4812.230043193107;6138.47822935051;7735.419843511703;7748.883766743504;7760.495567788075;7784.455088143832;4751.097291514601;4888.315635810918;4896.11869863428;4901.730404827768;4903.092927808367;3870.3807390817333;4952.158133117378;4998.175301075282;4999.725015124131;5000.1749711297225;5913.201717768132;5915.260592425947;5932.19915311436;5937.079752638348;5939.346671866091;7324;7324.267573242633;7325.340719335285;7336.193018767931;7347.155077166194;1665.100845543393;1711.4951089428648;1714.7427885817228;1721.0792226158944;1723.5001849463765;1042.452712326035;1079.09895237476;1118.1446193661855;1143.9256448330832;1150.3787954504473;6120.387961203933;6468.191476065492;6771.762988295386;6806.217285012287;6945.79162625112;7637.13607397226;7663.386929045774;7684.346830519468;7696.4227682924;7816.06207255133;6081.209442772411;6556.967215163989;6905.447564194953;6924.3421874921805;6950;3905.3946638271113;4040.4343391925154;4047.777372244555;4063.898402539901;4071.2875246832277;7245.5652660840515;7996.360291176692;7998.600069996593;8014.679412823539;8018.438709290411;7557.848843023109;7877.818327250959;7893.684252629945;7899.644515996794;7934.523928564305;7972.6412311444965;7972.960135199287;7978.640961156878;7991.200879912079;8003.079645840803;7620.504667196615;7623.390128789572;7634.656440460081;7637.809054773453;7639.809004774925;7270.054892863894;7477.027986361738;7489.775306740807;7543.245675432413;7570.697172113274;7979.241972012649;7990.121086680577;8010.439269251096;8023.398245131521;8025.9598702006115;4681.368015318025;4682.41469816273;4739.218029025173;4742.1227072991605;4743.264793956942;7406.740764073232;7575.166731659403;7582.128055273714;7595.430342724429;7604.277593628596;7304.890426643498;7319.707211711472;7321.633918303957;7325.890111648223;7334.743283985035;5982.252218472691;7102.289771022856;7317.012203352479;7317.414606831547;7350.77947661571;6419.807405777834;6580.7496575650475;7113.0753002109395;7122.18094919091;7140.571565705866;6997.440204783503;7119.85760284781;7257.149426896108;7281.308275713799;7344.081989751281;5861.443162899518;7162.104736907887;7206.351428371262;7207.459440541876;7209.062821833338 05:17:55 INFO - PROCESS | 1988 | |5;yui.html;674.5783885071829;710.5203987308565;713.5575942915393;713.9000539924411;724.8332883436808;14088.859111408883;14845.851541484582;15211.46759863405;15215.847841521581;15860.52418427449;15312.846871531281;15470.303836327392;15476.458323958665;15579.922100389482;15619;864.5633954852791;867.9652813887437;877.9078196789341;880.8238352329528;882.6160620130232;882.9293656507464;885.8538341173698;886.0961818944672;886.8315020146184;887.0818702642766;924.2467389077914;929.9395539289925;931.0596297739264;931.0735817861238;931.1340453378356;771.3674786674928;901.7565257380503;917.6696389299847;925.4354843545466;927.6104036304769;668.8394785251553;673.8551211489553;682.1370965728357;682.2086379799409;689.8240948558085;12257.264564126091;15047.924760376238;15073.170975596338;15134.318955647022;15162;12350.876491235062;12542.498300067986;12637;12825.16636418639;12844.678883027906;9889.604415823358;9961.45212013339;10041.096301332915;10069.244806639457;10586.735331616694;3505.263894582141;3562;3579.7113039305827;3626.1659818241687;3747.419150031722;79988;80504;81665.18334816635;89788.10211897863;90831.09168908292;9654.324197306121;9982.35114717541;10100.898991009995;10108.39349639024;10416.531256093494;21857;22149.557008859734;22168.224112155996;22178.44553886166;22306.776932230794;7630.351420129351;7686.730964416219;7720.575368354795;7775.5723435210475;7793.2596403341595;4047.1500984792933;4128.1330920507025;4140.565240649748;4142.420061191436;4160.313548264502;3490.982545087258;3518.9120271993406;3533.116720819795;3538;3541.061618671054;634.7365843175123;647.9028145778171;652.6345246661884;670.7484693240035;673.7069374821968;503.3129777853204;543.3615501785387;598.9341172471024;638.581728967527;639.7500696461962;8303.169683031769;8555.443896146855;8684.131586841266;8839.248663863644;8869.866951995726;565.6492974355925;595.7944509144338;608.5223099866672;618.8767387192231;620.4292051312804;4035.9798201009394;4046.8988275293354;4119.505659320901;4334.696571239983;4412.757298348557;88344.11655883359;89789;92168;100164;100760.99239007516;77731.22268777352;77789.61105194438;81588;81953.59023204965;83486.58256708678;66755.664886702;67831.66084169646;71179.28820711726;71608.64195678988;71917.28082719211;8045.436819422584;8861.955690221508;9142.268618510636;9178.990311065643;9190.218831399407;51871.2219316703;52997;53488.73255633697;54091.18863216976;54466;71625;71903.28096718965;72451.63774181095;73247;74138.62930685312;10044.347117437343;10155.543000564845;10591.576336946744;10959.301308297227;11003.61487347939;11785.292882427082;11935.462904169506;12339.07456940715;12359.134860559674;12410.255384676948;11124.332540047622;11397.886021140013;11445.370504622326;11771.23486973344;12022.218555793845;9896.703098907044;11036.11711063129;11472.770544589228;11871;12339.69150771238;11309.886901130883;11751.823722643996;11763.353015584225;11780;12305.44625491873;9359.812803743751;9394.530273486162;9713.951430242803;9808.460534670661;9940.005999400002;9304.95347523258;9865.210783137189;10062.39625622465;10086.041826026516;10106.494675266355 05:17:55 INFO - PROCESS | 1988 | __end_tp_report 05:17:55 INFO - PROCESS | 1988 | __start_cc_report 05:17:55 INFO - PROCESS | 1988 | _x_x_mozilla_cycle_collect,359 05:17:55 INFO - PROCESS | 1988 | __end_cc_report 05:17:55 INFO - PROCESS | 1988 | __startTimestamp1455801475166__endTimestamp 05:17:55 INFO - PROCESS | 1988 | 05:17:55 INFO - PROCESS | 1988 | ------- Summary: start ------- 05:17:55 INFO - PROCESS | 1988 | Number of tests: 6 05:17:55 INFO - PROCESS | 1988 | 05:17:55 INFO - PROCESS | 1988 | [#0] dojo.html Cycles:165 Average:5810.29 Median:6101.79 stddev:653.33 (10.7%) stddev-sans-first:622.82 05:17:55 INFO - PROCESS | 1988 | Values: 3215.6 3527.3 3568.3 3594.6 3599.9 5859.6 5865.0 5934.7 5935.4 5943.2 5186.2 5745.3 5846.0 5931.0 6092.4 5248.1 5259.9 5314.4 5355.8 5370.5 5392.3 5402.9 5403.8 5404.1 5433.4 4819.0 4904.6 5313.4 5318.2 5338.1 5284.1 5288.7 5314.5 5316.0 5326.6 5203.2 5241.9 5268.6 5312.8 5338.5 5742.6 5748.2 5776.0 5785.2 5846.7 6184.1 6230.9 6232.5 6233.3 6249.8 6149.9 6228.8 6267.6 6281.5 6289.6 5139.3 5747.7 5981.5 5988.0 6004.5 6393.0 6393.6 6393.9 6400.5 6407.5 6106.8 6173.5 6248.3 6255.4 6261.6 6255.7 6260.8 6265.7 6307.0 6310.9 6178.0 6181.2 6252.4 6259.6 6267.7 6225.5 6228.7 6236.1 6236.2 6251.8 4277.7 4806.8 4961.7 4961.8 4999.6 4384.7 4435.8 4464.2 4483.7 4535.9 5911.4 6002.2 6004.0 6004.8 6022.9 4798.6 6282.4 6287.4 6305.1 6322.2 6008.2 6034.9 6050.3 6062.6 6101.8 5460.1 5470.9 5483.1 5521.7 5531.4 6033.9 6308.1 6403.8 6465.3 6468.2 6217.9 6268.3 6273.0 6276.9 6280.8 6487.0 6497.3 6500.8 6505.8 6527.0 5791.9 5851.1 6154.1 6251.3 6260.9 5226.8 6242.3 6259.7 6268.6 6272.7 6134.7 6135.3 6196.4 6246.3 6250.9 6192.5 6217.8 6218.4 6224.6 6238.0 5472.5 6045.3 6164.7 6170.9 6179.9 6101.5 6129.9 6213.9 6219.2 6225.2 6116.7 6137.2 6163.6 6170.6 6183.6 05:17:55 INFO - PROCESS | 1988 | 05:17:55 INFO - PROCESS | 1988 | [#1] ext.html Cycles:180 Average:61667.62 Median:366320.50 stddev:127299.65 (34.8%) stddev-sans-first:127573.77 05:17:55 INFO - PROCESS | 1988 | Values: 445.3 455.1 490.2 553.8 591.6 29962.6 37711.8 37955.0 38095.4 38096.0 39595.0 39804.0 40162.4 40239.0 40644.8 9512.2 9702.3 9733.5 9784.0 9786.6 9530.4 9790.5 9847.6 9847.6 9856.0 9765.8 9773.0 9856.7 9863.7 9890.0 9745.0 9765.1 9827.2 9858.6 9867.1 9701.5 9844.0 9864.1 9874.1 9902.5 32197.5 38134.6 38954.8 38965.8 39379.8 2788.9 3177.3 3252.5 3374.6 3414.0 26914.6 27300.3 27731.4 27832.6 28288.2 2745.4 2785.8 2826.3 2892.5 2966.2 363800.0 364737.0 365558.0 366320.0 366321.0 55878.7 65646.3 66846.0 66952.7 66953.7 63975.7 64112.7 64650.0 64794.4 64819.0 16136.2 16432.5 16455.9 16517.8 16605.8 10553.4 12602.5 12631.6 12825.5 13150.4 17611.2 21268.8 21301.6 21568.6 21592.6 7278.3 7601.9 8447.5 8682.7 8720.0 861.7 943.8 973.7 1099.0 1186.1 29435.3 29679.9 29719.4 30223.8 30261.4 1066.5 1113.1 1167.0 1238.7 1257.7 16123.1 16160.8 16240.9 16423.7 16480.8 567358.0 577084.0 578469.0 580318.0 583333.0 59252.7 59489.7 59703.0 59868.7 59934.1 1415.7 1418.7 1435.8 1441.9 1453.1 30336.9 30601.1 30619.0 31026.2 31161.7 51716.0 51964.7 52281.0 52296.0 52362.0 368184.2 438672.0 439138.0 534141.0 536198.0 31259.0 32454.5 33225.8 33226.2 33361.7 41720.8 41812.6 42071.0 42197.6 42683.8 31077.8 32878.2 34353.5 35373.3 35832.6 34769.8 35746.0 36264.0 36283.5 36528.8 36218.1 36412.1 36578.5 36722.6 36805.4 30559.1 32247.4 32629.5 32630.0 32678.5 24610.3 24759.9 24761.9 25096.1 25149.0 05:17:55 INFO - PROCESS | 1988 | 05:17:55 INFO - PROCESS | 1988 | [#2] jquery.html Cycles:180 Average:36924.41 Median:2083.73 stddev:125111.93 (6004.2%) stddev-sans-first:125432.77 05:17:55 INFO - PROCESS | 1988 | Values: 358.5 362.6 365.7 367.8 368.6 15552.0 19186.3 19277.5 19610.5 20328.3 11507.5 11645.4 11674.3 12302.4 18651.0 3967.4 5128.4 5150.9 5421.5 5441.1 5692.4 6003.6 6011.5 6015.2 6027.2 5940.0 6021.1 6535.2 6535.2 6561.4 5445.1 5700.1 6387.7 6462.6 6474.9 4581.8 5183.5 5384.7 5462.6 5468.0 12448.8 12680.2 12726.4 14488.6 23742.2 2159.3 2191.2 2259.7 2530.7 2717.3 9374.6 9414.2 9530.5 9545.9 9891.8 1686.6 1778.2 1787.8 1797.7 1804.9 94775.5 98306.0 98845.0 99651.5 99860.0 11202.3 11211.5 11363.2 11390.7 11454.7 11710.4 11896.8 12973.7 12997.7 13395.5 8480.0 8497.2 8552.9 8557.2 8608.4 7732.3 8019.7 8514.0 8649.1 8711.7 3798.9 3982.8 4000.5 4346.8 4465.7 1851.2 1891.6 1953.4 1962.8 1973.3 731.4 736.2 917.8 1064.8 1081.9 17738.0 18189.5 18710.8 19683.1 20005.8 864.7 971.6 972.3 980.9 1019.3 10032.1 10277.3 10543.9 10661.2 10774.2 754416.0 755704.0 758190.0 764488.0 772913.1 90458.0 105885.4 106282.0 107370.5 109503.5 1115.5 1125.3 1139.4 1141.1 1145.7 15234.5 17701.3 17798.4 17893.8 18155.1 32606.0 47062.5 49915.5 50077.7 50316.5 59705.7 61568.7 70160.9 70558.0 71401.9 7634.0 7780.6 7796.8 7797.3 7816.6 9709.4 11818.2 12109.4 12276.2 12385.1 4585.4 8194.3 9900.9 10398.9 10828.2 10036.8 10512.8 10549.9 10799.4 11220.2 8830.0 9546.7 10716.5 11103.6 11256.9 7398.3 7444.6 7700.9 7715.7 7732.2 8122.5 10522.4 10750.2 10847.6 10861.6 05:17:55 INFO - PROCESS | 1988 | 05:17:55 INFO - PROCESS | 1988 | [#3] mootools.html Cycles:180 Average:5911.80 Median:5357.25 stddev:3076.40 (57.4%) stddev-sans-first:3067.38 05:17:55 INFO - PROCESS | 1988 | Values: 1527.2 1528.0 1750.0 1858.6 1883.8 6902.2 7105.6 7806.2 8481.5 8530.8 8359.7 8395.2 8487.6 8505.6 8512.6 2426.8 2437.2 2447.9 2460.2 2464.7 2430.5 2469.5 2478.4 2480.5 2483.3 1906.9 2371.5 2400.2 2461.0 2463.2 2199.3 2269.8 2370.5 2399.2 2402.5 2030.8 2328.6 2415.6 2424.6 2449.0 8467.3 8471.0 8475.2 8519.4 8540.0 5195.7 5288.1 5322.9 5347.4 5367.1 3482.6 3587.3 3629.2 3690.4 3693.7 1063.3 1075.6 1081.8 1081.8 1082.4 11770.3 11796.5 11823.2 11827.5 11850.3 4808.6 4840.0 4881.9 4920.1 4926.0 9951.3 10049.9 10063.0 10067.3 10076.9 5403.5 5412.1 5442.0 5455.9 5458.8 4856.0 4902.2 4944.9 4955.4 4975.3 3955.8 3979.8 3980.7 3991.6 4025.0 1304.7 1307.2 1309.5 1327.9 1331.8 1016.9 1093.2 1120.2 1252.3 1367.9 7724.5 7812.8 7882.7 7922.9 7929.3 978.8 1184.7 1193.8 1194.6 1208.4 6055.6 6098.2 6143.7 6158.5 6198.1 9735.0 10385.4 10472.4 10527.4 10538.5 10212.0 10265.5 10333.7 10345.5 10401.4 6839.6 8015.4 8040.1 8129.1 8193.4 6492.9 7658.9 7672.8 7702.5 7741.6 8436.7 9055.6 9258.0 9375.5 9397.8 9446.9 9564.9 9565.6 9705.4 9718.8 7275.9 7288.7 7321.1 7322.6 7359.9 6886.0 7890.0 7920.6 8048.1 8069.6 5629.4 7528.4 7651.7 7712.8 7737.0 7346.3 7356.0 7359.7 7406.1 7462.6 7496.7 7539.2 7565.0 7567.3 7613.0 6816.7 6885.0 6890.6 6908.3 6917.7 6940.8 6972.2 7020.4 7050.8 7061.0 05:17:55 INFO - PROCESS | 1988 | 05:17:55 INFO - PROCESS | 1988 | [#4] prototype.html Cycles:180 Average:5971.50 Median:6760.59 stddev:1921.61 (28.4%) stddev-sans-first:1878.95 05:17:55 INFO - PROCESS | 1988 | Values: 282.2 297.6 319.4 326.2 327.7 6719.3 6834.9 6857.6 6881.3 6923.6 6759.4 6761.8 6766.6 6767.4 6793.5 4726.0 4850.2 4969.2 4981.8 4991.5 4924.2 4950.5 4976.3 4999.7 5000.6 4953.4 4957.3 4967.7 4968.6 4993.3 4949.4 4953.5 4958.1 4969.6 4986.0 4110.8 4216.7 4225.2 4277.6 4294.7 6468.5 6478.5 6496.6 6509.8 6519.2 5921.3 5923.1 5938.7 5939.9 5947.9 7010.7 7269.7 7284.6 7285.1 7304.4 4793.8 4795.5 4802.4 4806.1 4812.2 6138.5 7735.4 7748.9 7760.5 7784.5 4751.1 4888.3 4896.1 4901.7 4903.1 3870.4 4952.2 4998.2 4999.7 5000.2 5913.2 5915.3 5932.2 5937.1 5939.3 7324.0 7324.3 7325.3 7336.2 7347.2 1665.1 1711.5 1714.7 1721.1 1723.5 1042.5 1079.1 1118.1 1143.9 1150.4 6120.4 6468.2 6771.8 6806.2 6945.8 7637.1 7663.4 7684.3 7696.4 7816.1 6081.2 6557.0 6905.4 6924.3 6950.0 3905.4 4040.4 4047.8 4063.9 4071.3 7245.6 7996.4 7998.6 8014.7 8018.4 7557.8 7877.8 7893.7 7899.6 7934.5 7972.6 7973.0 7978.6 7991.2 8003.1 7620.5 7623.4 7634.7 7637.8 7639.8 7270.1 7477.0 7489.8 7543.2 7570.7 7979.2 7990.1 8010.4 8023.4 8026.0 4681.4 4682.4 4739.2 4742.1 4743.3 7406.7 7575.2 7582.1 7595.4 7604.3 7304.9 7319.7 7321.6 7325.9 7334.7 5982.3 7102.3 7317.0 7317.4 7350.8 6419.8 6580.7 7113.1 7122.2 7140.6 6997.4 7119.9 7257.1 7281.3 7344.1 5861.4 7162.1 7206.4 7207.5 7209.1 05:17:55 INFO - PROCESS | 1988 | 05:17:55 INFO - PROCESS | 1988 | [#5] yui.html Cycles:180 Average:18878.85 Median:613.70 stddev:26646.10 (4341.9%) stddev-sans-first:26685.79 05:17:55 INFO - PROCESS | 1988 | Values: 674.6 710.5 713.6 713.9 724.8 14088.9 14845.9 15211.5 15215.8 15860.5 15312.8 15470.3 15476.5 15579.9 15619.0 864.6 868.0 877.9 880.8 882.6 882.9 885.9 886.1 886.8 887.1 924.2 929.9 931.1 931.1 931.1 771.4 901.8 917.7 925.4 927.6 668.8 673.9 682.1 682.2 689.8 12257.3 15047.9 15073.2 15134.3 15162.0 12350.9 12542.5 12637.0 12825.2 12844.7 9889.6 9961.5 10041.1 10069.2 10586.7 3505.3 3562.0 3579.7 3626.2 3747.4 79988.0 80504.0 81665.2 89788.1 90831.1 9654.3 9982.4 10100.9 10108.4 10416.5 21857.0 22149.6 22168.2 22178.4 22306.8 7630.4 7686.7 7720.6 7775.6 7793.3 4047.2 4128.1 4140.6 4142.4 4160.3 3491.0 3518.9 3533.1 3538.0 3541.1 634.7 647.9 652.6 670.7 673.7 503.3 543.4 598.9 638.6 639.8 8303.2 8555.4 8684.1 8839.2 8869.9 565.6 595.8 608.5 618.9 620.4 4036.0 4046.9 4119.5 4334.7 4412.8 88344.1 89789.0 92168.0 100164.0 100761.0 77731.2 77789.6 81588.0 81953.6 83486.6 66755.7 67831.7 71179.3 71608.6 71917.3 8045.4 8862.0 9142.3 9179.0 9190.2 51871.2 52997.0 53488.7 54091.2 54466.0 71625.0 71903.3 72451.6 73247.0 74138.6 10044.3 10155.5 10591.6 10959.3 11003.6 11785.3 11935.5 12339.1 12359.1 12410.3 11124.3 11397.9 11445.4 11771.2 12022.2 9896.7 11036.1 11472.8 11871.0 12339.7 11309.9 11751.8 11763.4 11780.0 12305.4 9359.8 9394.5 9714.0 9808.5 9940.0 9305.0 9865.2 10062.4 10086.0 10106.5 05:17:55 INFO - PROCESS | 1988 | -------- Summary: end -------- 05:17:55 INFO - PROCESS | 1988 | 05:17:55 INFO - TEST-INFO | 1988: exit 0 05:17:55 INFO - TEST-OK | dromaeo_css | took 1111261ms 05:17:55 INFO - TEST-START | kraken 05:17:55 INFO - operating with platform_type : mac_ 05:17:55 INFO - Initialising browser for kraken test... 05:17:55 INFO - TEST-INFO | started process 1992 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/tmpFtu3sz/profile http://localhost:56104/getInfo.html) 05:17:58 INFO - PROCESS | 1992 | __metrics Screen width/height:1600/1200 05:17:58 INFO - PROCESS | 1992 | colorDepth:24 05:17:58 INFO - PROCESS | 1992 | Browser inner width/height: 1024/689 05:17:58 INFO - PROCESS | 1992 | __metrics 05:17:58 ERROR - PROCESS | 1992 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2871: TypeError: this.tabs is undefined 05:17:59 INFO - TEST-INFO | 1992: exit 0 05:17:59 INFO - Browser initialized. 05:17:59 INFO - Running cycle 1/1 for kraken test... 05:17:59 INFO - TEST-INFO | started process 1995 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/T/tmpFtu3sz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:18:11 INFO - PROCESS | 1995 | RSS: Main: 256790528 05:18:11 INFO - PROCESS | 1995 | 05:18:14 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:56104/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56104/tests/kraken/driver.html?testName=audio-beat-detection) 05:18:14 INFO - PROCESS | 1995 | RSS: Main: 268750848 05:18:14 INFO - PROCESS | 1995 | 05:18:17 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:56104/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56104/tests/kraken/driver.html?testName=audio-dft) 05:18:18 INFO - PROCESS | 1995 | RSS: Main: 278405120 05:18:18 INFO - PROCESS | 1995 | 05:18:21 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:56104/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56104/tests/kraken/driver.html?testName=audio-fft) 05:18:22 INFO - PROCESS | 1995 | RSS: Main: 280604672 05:18:22 INFO - PROCESS | 1995 | 05:18:24 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:56104/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56104/tests/kraken/driver.html?testName=audio-oscillator) 05:18:24 INFO - PROCESS | 1995 | RSS: Main: 281604096 05:18:24 INFO - PROCESS | 1995 | 05:18:27 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:56104/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56104/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:18:27 INFO - PROCESS | 1995 | RSS: Main: 282185728 05:18:27 INFO - PROCESS | 1995 | 05:18:30 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:56104/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56104/tests/kraken/driver.html?testName=imaging-darkroom) 05:18:30 INFO - PROCESS | 1995 | RSS: Main: 282124288 05:18:30 INFO - PROCESS | 1995 | 05:18:33 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:56104/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56104/tests/kraken/driver.html?testName=imaging-desaturate) 05:18:34 INFO - PROCESS | 1995 | RSS: Main: 283090944 05:18:34 INFO - PROCESS | 1995 | 05:18:37 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:56104/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56104/tests/kraken/driver.html?testName=json-parse-financial) 05:18:37 INFO - PROCESS | 1995 | RSS: Main: 283570176 05:18:37 INFO - PROCESS | 1995 | 05:18:39 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:56104/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56104/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:18:40 INFO - PROCESS | 1995 | RSS: Main: 283553792 05:18:40 INFO - PROCESS | 1995 | 05:18:41 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:56104/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56104/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:18:42 INFO - PROCESS | 1995 | RSS: Main: 284295168 05:18:42 INFO - PROCESS | 1995 | 05:18:44 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:56104/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56104/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:18:45 INFO - PROCESS | 1995 | RSS: Main: 284696576 05:18:45 INFO - PROCESS | 1995 | 05:18:47 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:56104/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:18:48 INFO - PROCESS | 1995 | RSS: Main: 283787264 05:18:48 INFO - PROCESS | 1995 | 05:18:50 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:56104/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:18:51 INFO - PROCESS | 1995 | RSS: Main: 284155904 05:18:51 INFO - PROCESS | 1995 | 05:18:53 INFO - PROCESS | 1995 | Cycle 1(1): loaded http://localhost:56104/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56104/tests/kraken/driver.html?testName=ai-astar) 05:18:53 INFO - PROCESS | 1995 | RSS: Main: 285224960 05:18:53 INFO - PROCESS | 1995 | 05:18:53 INFO - PROCESS | 1995 | __start_tp_report 05:18:53 INFO - PROCESS | 1995 | _x_x_mozilla_page_load 05:18:53 INFO - PROCESS | 1995 | _x_x_mozilla_page_load_details 05:18:53 INFO - PROCESS | 1995 | |i|pagename|runs| 05:18:53 INFO - PROCESS | 1995 | |0;ai-astar;117;107;114;113;115;126;114;113;116;115 05:18:53 INFO - PROCESS | 1995 | |1;audio-beat-detection;154;122;148;155;119;181;165;113;190;156 05:18:53 INFO - PROCESS | 1995 | |2;audio-dft;193;239;262;213;207;199;242;251;203;197 05:18:53 INFO - PROCESS | 1995 | |3;audio-fft;82;72;73;144;84;86;74;59;88;58 05:18:53 INFO - PROCESS | 1995 | |4;audio-oscillator;81;88;118;80;80;82;120;123;120;103 05:18:53 INFO - PROCESS | 1995 | |5;imaging-gaussian-blur;88;95;86;93;88;94;86;94;88;95 05:18:53 INFO - PROCESS | 1995 | |6;imaging-darkroom;95;96;97;129;107;152;154;94;98;106 05:18:53 INFO - PROCESS | 1995 | |7;imaging-desaturate;91;96;93;91;93;97;93;95;93;110 05:18:53 INFO - PROCESS | 1995 | |8;json-parse-financial;56;56;57;55;58;55;58;64;58;59 05:18:53 INFO - PROCESS | 1995 | |9;json-stringify-tinderbox;67;68;63;71;65;66;67;65;71;67 05:18:53 INFO - PROCESS | 1995 | |10;stanford-crypto-aes;88;86;86;80;102;84;83;83;87;86 05:18:53 INFO - PROCESS | 1995 | |11;stanford-crypto-ccm;125;126;124;141;132;135;130;117;115;115 05:18:53 INFO - PROCESS | 1995 | |12;stanford-crypto-pbkdf2;176;161;141;145;145;144;144;141;131;137 05:18:53 INFO - PROCESS | 1995 | |13;stanford-crypto-sha256-iterative;67;68;63;66;70;68;69;73;68;57 05:18:53 INFO - PROCESS | 1995 | __end_tp_report 05:18:53 INFO - PROCESS | 1995 | __start_cc_report 05:18:53 INFO - PROCESS | 1995 | _x_x_mozilla_cycle_collect,911 05:18:53 INFO - PROCESS | 1995 | __end_cc_report 05:18:53 INFO - PROCESS | 1995 | __startTimestamp1455801533449__endTimestamp 05:18:53 INFO - PROCESS | 1995 | 05:18:53 INFO - PROCESS | 1995 | ------- Summary: start ------- 05:18:53 INFO - PROCESS | 1995 | Number of tests: 14 05:18:53 INFO - PROCESS | 1995 | 05:18:53 INFO - PROCESS | 1995 | [#0] ai-astar Cycles:10 Average:115.00 Median:115.00 stddev:4.71 (4.1%) stddev-sans-first:4.94 05:18:53 INFO - PROCESS | 1995 | Values: 117.0 107.0 114.0 113.0 115.0 126.0 114.0 113.0 116.0 115.0 05:18:53 INFO - PROCESS | 1995 | 05:18:53 INFO - PROCESS | 1995 | [#1] audio-beat-detection Cycles:10 Average:150.30 Median:155.50 stddev:25.78 (16.6%) stddev-sans-first:27.31 05:18:53 INFO - PROCESS | 1995 | Values: 154.0 122.0 148.0 155.0 119.0 181.0 165.0 113.0 190.0 156.0 05:18:53 INFO - PROCESS | 1995 | 05:18:53 INFO - PROCESS | 1995 | [#2] audio-dft Cycles:10 Average:220.60 Median:226.00 stddev:25.33 (11.2%) stddev-sans-first:24.81 05:18:53 INFO - PROCESS | 1995 | Values: 193.0 239.0 262.0 213.0 207.0 199.0 242.0 251.0 203.0 197.0 05:18:53 INFO - PROCESS | 1995 | 05:18:53 INFO - PROCESS | 1995 | [#3] audio-fft Cycles:10 Average:82.00 Median:78.00 stddev:24.15 (31.0%) stddev-sans-first:25.62 05:18:53 INFO - PROCESS | 1995 | Values: 82.0 72.0 73.0 144.0 84.0 86.0 74.0 59.0 88.0 58.0 05:18:53 INFO - PROCESS | 1995 | 05:18:53 INFO - PROCESS | 1995 | [#4] audio-oscillator Cycles:10 Average:99.50 Median:80.00 stddev:19.12 (23.9%) stddev-sans-first:19.07 05:18:53 INFO - PROCESS | 1995 | Values: 81.0 88.0 118.0 80.0 80.0 82.0 120.0 123.0 120.0 103.0 05:18:53 INFO - PROCESS | 1995 | 05:18:53 INFO - PROCESS | 1995 | [#5] imaging-gaussian-blur Cycles:10 Average:90.70 Median:93.50 stddev:3.80 (4.1%) stddev-sans-first:3.91 05:18:53 INFO - PROCESS | 1995 | Values: 88.0 95.0 86.0 93.0 88.0 94.0 86.0 94.0 88.0 95.0 05:18:53 INFO - PROCESS | 1995 | 05:18:53 INFO - PROCESS | 1995 | [#6] imaging-darkroom Cycles:10 Average:112.80 Median:94.50 stddev:23.56 (24.9%) stddev-sans-first:24.10 05:18:53 INFO - PROCESS | 1995 | Values: 95.0 96.0 97.0 129.0 107.0 152.0 154.0 94.0 98.0 106.0 05:18:53 INFO - PROCESS | 1995 | 05:18:53 INFO - PROCESS | 1995 | [#7] imaging-desaturate Cycles:10 Average:95.20 Median:93.00 stddev:5.55 (6.0%) stddev-sans-first:5.68 05:18:53 INFO - PROCESS | 1995 | Values: 91.0 96.0 93.0 91.0 93.0 97.0 93.0 95.0 93.0 110.0 05:18:53 INFO - PROCESS | 1995 | 05:18:53 INFO - PROCESS | 1995 | [#8] json-parse-financial Cycles:10 Average:57.60 Median:58.00 stddev:2.63 (4.5%) stddev-sans-first:2.73 05:18:53 INFO - PROCESS | 1995 | Values: 56.0 56.0 57.0 55.0 58.0 55.0 58.0 64.0 58.0 59.0 05:18:53 INFO - PROCESS | 1995 | 05:18:53 INFO - PROCESS | 1995 | [#9] json-stringify-tinderbox Cycles:10 Average:67.00 Median:67.00 stddev:2.54 (3.8%) stddev-sans-first:2.69 05:18:53 INFO - PROCESS | 1995 | Values: 67.0 68.0 63.0 71.0 65.0 66.0 67.0 65.0 71.0 67.0 05:18:53 INFO - PROCESS | 1995 | 05:18:53 INFO - PROCESS | 1995 | [#10] stanford-crypto-aes Cycles:10 Average:86.50 Median:86.00 stddev:5.93 (6.9%) stddev-sans-first:6.26 05:18:53 INFO - PROCESS | 1995 | Values: 88.0 86.0 86.0 80.0 102.0 84.0 83.0 83.0 87.0 86.0 05:18:53 INFO - PROCESS | 1995 | 05:18:53 INFO - PROCESS | 1995 | [#11] stanford-crypto-ccm Cycles:10 Average:126.00 Median:128.00 stddev:8.73 (6.8%) stddev-sans-first:9.25 05:18:53 INFO - PROCESS | 1995 | Values: 125.0 126.0 124.0 141.0 132.0 135.0 130.0 117.0 115.0 115.0 05:18:53 INFO - PROCESS | 1995 | 05:18:53 INFO - PROCESS | 1995 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:146.50 Median:144.50 stddev:12.86 (8.9%) stddev-sans-first:8.07 05:18:53 INFO - PROCESS | 1995 | Values: 176.0 161.0 141.0 145.0 145.0 144.0 144.0 141.0 131.0 137.0 05:18:53 INFO - PROCESS | 1995 | 05:18:53 INFO - PROCESS | 1995 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.90 Median:68.00 stddev:4.33 (6.4%) stddev-sans-first:4.59 05:18:53 INFO - PROCESS | 1995 | Values: 67.0 68.0 63.0 66.0 70.0 68.0 69.0 73.0 68.0 57.0 05:18:53 INFO - PROCESS | 1995 | -------- Summary: end -------- 05:18:53 INFO - PROCESS | 1995 | 05:18:54 INFO - TEST-INFO | 1995: exit 0 05:18:54 INFO - TEST-OK | kraken | took 58500ms 05:18:54 INFO - SUITE-END | took 1169s 05:18:54 INFO - Completed test suite (00:19:30) 05:18:54 INFO - Working with test: dromaeo_css 05:18:54 INFO - Generating results file: dromaeo_css 05:18:54 INFO - Working with test: kraken 05:18:54 INFO - Generating results file: kraken 05:18:54 INFO - javascript benchmark 05:18:54 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:54 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 05:18:54 INFO - process_Request line: dromaeo_css 7528.81 graph.html#tests=[[72,1,61]] 05:18:54 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:18:54 INFO - process_Request line: kraken 1516.60 graph.html#tests=[[232,1,61]] 05:18:54 INFO - RETURN: dromaeo_css: 7528.81 05:18:54 INFO - RETURN: kraken: 1516.60 05:18:54 INFO - javascript benchmark 05:18:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3215.64627890932, 3527.276908233811, 3568.3041806847673, 3594.604593494717, 3599.8740044098463, 5859.648421094732, 5864.970675146624, 5934.673592952386, 5935.436133567309, 5943.197668314776, 5186.196139598359, 5745.2818397700285, 5845.970770146154, 5931.0, 6092.390760923905, 5248.088757219977, 5259.9474005259935, 5314.388845282803, 5355.758990845402, 5370.543503802162, 5392.272043274166, 5402.8919421611545, 5403.8108666196695, 5404.135338345865, 5433.402325744185, 4819.0, 4904.558589726924, 5313.362396512404, 5318.175682769177, 5338.145896656536, 5284.101702710548, 5288.68267903927, 5314.468553144693, 5316.043112239795, 5326.573874090063, 5203.167493201107, 5241.9213711794355, 5268.578513718893, 5312.814051508179, 5338.466153384669, 5742.626729262584, 5748.16651585522, 5776.046952252916, 5785.247917770663, 5846.736896839652, 6184.134221209034, 6230.937690623126, 6232.470240029603, 6233.283172435137, 6249.812505624793, 6149.907751383733, 6228.844278893019, 6267.561270711052, 6281.497480201573, 6289.622622642611, 5139.306193663845, 5747.741351639186, 5981.461668449861, 5988.04191329394, 6004.4595986361, 6393.0, 6393.552451328363, 6393.872122557523, 6400.519961002943, 6407.519436042222, 6106.794380079898, 6173.475254603409, 6248.28144763349, 6255.374462553708, 6261.5616906816995, 6255.6872156392, 6260.812175634738, 6265.749370025148, 6307.0, 6310.873782524415, 6177.96911015442, 6181.227346581677, 6252.374762523711, 6259.624422534663, 6267.6866156691985, 6225.533085018642, 6228.6574238416415, 6236.095766113888, 6236.158118654014, 6251.843703907348, 4277.679174061957, 4806.831760888352, 4961.6526843121355, 4961.801527938842, 4999.5500404963, 4384.7369157850635, 4435.844745433894, 4464.196444639996, 4483.730976141442, 4535.931961020588, 5911.438413350725, 6002.219711437485, 6003.969980150158, 6004.789832355847, 6022.939770602238, 4798.568128868418, 6282.371762823681, 6287.402696743802, 6305.054241863665, 6322.241331040213, 6008.218931538872, 6034.939650603438, 6050.273967123885, 6062.575619706667, 6101.786437474667, 5460.071787796084, 5470.91793623096, 5483.095289277305, 5521.668699878021, 5531.3915469298345, 6033.879322413527, 6308.148399966038, 6403.807885763435, 6465.321141280097, 6468.191476065492, 6217.906731398942, 6268.341824108403, 6272.968635156795, 6276.905846412216, 6280.780172693934, 6486.99451585005, 6497.310699218143, 6500.772472963424, 6505.772297969548, 6527.0, 5791.855203619774, 5851.093080572518, 6154.076888466766, 6251.312355640966, 6260.874782504234, 5226.817061402832, 6242.3133455320785, 6259.6870156492905, 6268.561200716089, 6272.655003974825, 6134.6625935573975, 6135.263289243823, 6196.380361963767, 6246.281677606951, 6250.9062364065485, 6192.535559832941, 6217.813465596039, 6218.378162183926, 6224.564280500322, 6238.0, 5472.50747432733, 6045.274567051982, 6164.660943648142, 6170.907436388368, 6179.938200617937, 6101.489633126266, 6129.8784197560135, 6213.9067913980425, 6219.160413344141, 6225.159603453476, 6116.66358350295, 6137.232845894263, 6163.630182189083, 6170.568060235741, 6183.628982261079], "unit": "score", "name": "dojo.html", "value": 5770.282412384047}, {"lowerIsBetter": false, "replicates": [445.27420304903023, 455.1170728786155, 490.2254437987979, 553.798257780616, 591.645012992205, 29962.550561741566, 37711.81144094282, 37955.0, 38095.42856857143, 38096.0, 39595.0101247469, 39804.0, 40162.39756403656, 40238.99402514938, 40644.796776016075, 9512.23902087833, 9702.272329575275, 9733.464659443727, 9784.0, 9786.608535658565, 9530.380525265835, 9790.461524616143, 9847.60609575616, 9847.606095756197, 9856.0, 9765.755856103584, 9772.951135244313, 9856.704298871009, 9863.654772082979, 9890.0, 9745.02549745027, 9765.12113909748, 9827.213822894151, 9858.556364963593, 9867.11195992364, 9701.51492425383, 9844.0, 9864.112229899343, 9874.061964113398, 9902.504874756305, 32197.51703724446, 38134.61865381366, 38954.80522597397, 38965.80517097425, 39379.8031009846, 2788.916332510028, 3177.2851108500636, 3252.47960326349, 3374.6119196292493, 3413.9829300853335, 26914.5962810558, 27300.31749206286, 27731.445371092464, 27832.582511262346, 28288.15135545937, 2745.3685652299882, 2785.777137828969, 2826.3499395139233, 2892.47935371633, 2966.1546459259225, 363800.0, 364737.0, 365558.0, 366320.0, 366321.0, 55878.72060639671, 65646.34353656498, 66846.0, 66952.6652366735, 66953.66523167353, 63975.68012159909, 64112.67943660345, 64650.0, 64794.352056478834, 64819.0, 16136.193190340437, 16432.507024789276, 16455.917720411322, 16517.752233716263, 16605.750913736305, 10553.366797991992, 12602.49590016389, 12631.557895473614, 12825.486980520862, 13150.408231629408, 17611.207495662726, 21268.78731212699, 21301.573968520544, 21568.56862862734, 21592.56814863694, 7278.272172782679, 7601.923980760122, 8447.536510030857, 8682.6526938923, 8719.956400218085, 861.7027125641644, 943.7970836270235, 973.6932866147141, 1099.0, 1186.0867132308074, 29435.264118397212, 29679.85160074229, 29719.40561188764, 30223.79104835826, 30261.394772104435, 1066.4720963123305, 1113.0817075912405, 1166.9649910502699, 1238.6593686736219, 1257.7358754661623, 16123.11322877253, 16160.75758863618, 16240.918795405947, 16423.67152656964, 16480.84634075627, 567358.0, 577084.0, 578469.0, 580318.0, 583333.0, 59252.70373648104, 59489.70255148697, 59703.0, 59868.70065649731, 59934.10098848521, 1415.6602415420225, 1418.6595217148017, 1435.7559214933488, 1441.9134851908918, 1453.0772959171002, 30336.938207162642, 30601.08196754101, 30619.0, 31026.224344391572, 31161.688383116787, 51716.0, 51964.740176298874, 52281.0, 52296.0, 52362.0, 368184.1590792029, 438672.0, 439138.0, 534141.0, 536198.0, 31259.0, 32454.513182302755, 33225.833870831455, 33226.169345766546, 33361.66638333683, 41720.79139604283, 41812.58187418087, 42071.0, 42197.578024219365, 42683.786581066895, 31077.844610776803, 32878.1780455481, 34353.484697730055, 35373.292534148655, 35832.64167358293, 34769.826150869085, 35746.0, 36264.0, 36283.45574816433, 36528.81735591305, 36218.09454763652, 36412.089697757765, 36578.45132322964, 36722.63277367192, 36805.44791828178, 30559.08322750321, 32247.35505289928, 32629.510557342135, 32630.0, 32678.50982235316, 24610.261692149263, 24759.87620061888, 24761.876190618932, 25096.12163574339, 25149.0], "unit": "score", "name": "ext.html", "value": 19609.88235464503}, {"lowerIsBetter": false, "replicates": [358.541067433685, 362.6409854244298, 365.73484223937646, 367.8050633164424, 368.58718235576157, 15552.009861668246, 19186.328478503256, 19277.51806204844, 19610.509737256558, 20328.288509902173, 11507.482163302651, 11645.369648249252, 11674.299542027484, 12302.384880755948, 18650.974196419193, 3967.444557761916, 5128.384593848734, 5150.8712282193055, 5421.512063914247, 5441.102218134003, 5692.373838877741, 6003.57974941752, 6011.5190784737115, 6015.187949626788, 6027.156198132265, 5940.04959206527, 6021.09683547467, 6535.215774107114, 6535.24844642865, 6561.442277406426, 5445.101558242885, 5700.087985922232, 6387.680615969206, 6462.579932304385, 6474.931636280008, 4581.785826755912, 5183.533481986601, 5384.73076346185, 5462.617616766828, 5467.988422141877, 12448.75102497954, 12680.23918564889, 12726.363681815965, 14488.637784055378, 23742.169024084247, 2159.287435146398, 2191.244020812817, 2259.706238189025, 2530.746925307473, 2717.34550735844, 9374.625014999392, 9414.199793017602, 9530.475823829687, 9545.856812147824, 9891.752706182404, 1686.5699246692016, 1778.2086971297779, 1787.8033416324195, 1797.6854050541103, 1804.8917064976145, 94775.52612236894, 98306.0, 98845.0, 99651.50174249083, 99860.0, 11202.327860328407, 11211.495482703298, 11363.204575679623, 11390.715232119263, 11454.713632159095, 11710.355930423908, 11896.750841161727, 12973.740525189443, 12997.700229976926, 13395.531156409479, 8480.0, 8497.150284971576, 8552.871706924401, 8557.187067228604, 8608.440451370641, 7732.30409263169, 8019.676753335634, 8514.0, 8649.135086491426, 8711.651533938571, 3798.867039653599, 3982.8008599569907, 4000.5398029718945, 4346.847860324873, 4465.665075119379, 1851.1854783895044, 1891.640588288221, 1953.4335042837417, 1962.8429725621916, 1973.3093417304117, 731.4148681055241, 736.2403854787063, 917.8435171683726, 1064.808334499782, 1081.8972197641212, 17738.0, 18189.45431637053, 18710.81289187118, 19683.114259858055, 20005.799942000685, 864.7103220421103, 971.5814910231, 972.2902281334665, 980.8528720691811, 1019.2864994503877, 10032.097111260022, 10277.331973421704, 10543.947280263703, 10661.200409969284, 10774.24580279373, 754416.0, 755704.0, 758190.0, 764488.0, 772913.1354343193, 90458.0, 105885.41171882428, 106282.0, 107370.46314768377, 109503.45248273708, 1115.4757264085868, 1125.2798209146154, 1139.4359791903062, 1141.1099342512853, 1145.699630918913, 15234.466793662168, 17701.291948321923, 17798.37705680295, 17893.821061789735, 18155.092245387412, 32606.0, 47062.52937470582, 49915.50084499254, 50077.74961125171, 50316.496835032645, 59705.701471492364, 61568.692156540725, 70160.94758578727, 70558.0, 71401.92897106652, 7633.961830190813, 7780.572068536058, 7796.805079873048, 7797.337226335598, 7816.6091695416135, 9709.36889102206, 11818.231814932002, 12109.394530273627, 12276.202046866925, 12385.133040687066, 4585.426821647294, 8194.34445244367, 9900.900990989998, 10398.948005259925, 10828.24202305831, 10036.849447258151, 10512.789744205225, 10549.89450105489, 10799.352038877692, 11220.214584978972, 8829.955850220707, 9546.713598592054, 10716.464176790972, 11103.5558577656, 11256.874312568678, 7398.260173982559, 7444.627768611656, 7700.922990770245, 7715.729949451742, 7732.226777322223, 8122.5126492410645, 10522.421266830397, 10750.193735470028, 10847.566097356017, 10861.565537378416], "unit": "score", "name": "jquery.html", "value": 8891.49312613746}, {"lowerIsBetter": false, "replicates": [1527.2363818090955, 1527.9694406111876, 1749.9737503937442, 1858.553947052707, 1883.80220076892, 6902.206246281679, 7105.57888422315, 7806.219378062191, 8481.491110533372, 8530.786730331736, 8359.749207523784, 8395.160483951617, 8487.575621218944, 8505.617247223874, 8512.616932238048, 2426.8058555315574, 2437.244454219189, 2447.9265622031367, 2460.2250291158316, 2464.7042354917435, 2430.5417148323845, 2469.4814089041324, 2478.4423504711385, 2480.466699659573, 2483.279848843842, 1906.8665193436466, 2371.454565449939, 2400.1599440195964, 2460.963085553718, 2463.2117722328862, 2199.274239500961, 2269.8310370159465, 2370.514044620857, 2399.172285561487, 2402.531506356261, 2030.7766145723958, 2328.604137296664, 2415.613501839715, 2424.648425978241, 2449.0326321103244, 8467.280281176107, 8471.0, 8475.237228649452, 8519.36104792137, 8539.957300213458, 5195.68825870449, 5288.10102282609, 5322.866928326784, 5347.438518955492, 5367.06076436626, 3482.6169121396624, 3587.2646107548153, 3629.165291982859, 3690.4279836625365, 3693.686036686858, 1063.2504084620325, 1075.60708881998, 1081.7511972246348, 1081.8323159910226, 1082.426314053545, 11770.293782372999, 11796.528138874435, 11823.231489953125, 11827.526898924032, 11850.3482308473, 4808.567228949411, 4839.9836034433165, 4881.8535443936735, 4920.138975679313, 4925.950740492621, 9951.303408761318, 10049.899501004897, 10063.0, 10067.345622534513, 10076.949615251877, 5403.540699040547, 5412.07994640912, 5442.0, 5455.890882182413, 5458.754356053987, 4855.95144048555, 4902.2156454967035, 4944.851654450372, 4955.430125535538, 4975.328330675385, 3955.802209889494, 3979.8408063677707, 3980.7014473914574, 3991.560928297885, 4025.0, 1304.7455746129413, 1307.2222027893388, 1309.4500309869686, 1327.9136856104321, 1331.793571996342, 1016.8881423043459, 1093.2183488805383, 1120.2046546951592, 1252.2549083295426, 1367.924764137982, 7724.459287849797, 7812.843743125106, 7882.724104656424, 7922.920770792333, 7929.326007289445, 978.8287049766262, 1184.6682928779956, 1193.8209268609778, 1194.5818963362753, 1208.3958020989505, 6055.636661800306, 6098.237720284965, 6143.692815359214, 6158.538109641705, 6198.101275315054, 9734.95132524347, 10385.428801415843, 10472.371657700562, 10527.368357898551, 10538.473076346152, 10212.0, 10265.486725663686, 10333.689989300334, 10345.482725863676, 10401.375917444977, 6839.623820689811, 8015.358771298283, 8040.075391330072, 8129.105798362057, 8193.385496087818, 6492.935070649233, 7658.923410765821, 7672.769816905502, 7702.499337543042, 7741.612919354123, 8436.662533498591, 9055.592498337459, 9257.981622021438, 9375.531223438664, 9397.765055873384, 9446.905530944603, 9564.90435095668, 9565.569549370433, 9705.417674939526, 9718.805623887341, 7275.927240727525, 7288.744893928687, 7321.12146542397, 7322.645310617553, 7359.926400735924, 6886.0, 7890.013748281465, 7920.643571039202, 8048.114707382067, 8069.5965201740855, 5629.352624448077, 7528.360089392244, 7651.732189373345, 7712.807179820549, 7737.0, 7346.265373462611, 7355.963220183865, 7359.742409015659, 7406.111266648037, 7462.589557574169, 7496.700131994659, 7539.2083831199125, 7564.962175189089, 7567.31894129531, 7612.961935190288, 6816.693248803716, 6885.0, 6890.552114112566, 6908.274631163656, 6917.7232910685025, 6940.826479338057, 6972.233054363915, 7020.438364930896, 7050.753223637148, 7061.011458395726], "unit": "score", "name": "mootools.html", "value": 4847.702490973615}, {"lowerIsBetter": false, "replicates": [282.22388431812516, 297.61904761904765, 319.3580902386203, 326.21707901037524, 327.7279857718094, 6719.294474080219, 6834.931650683492, 6857.58854468731, 6881.277465866087, 6923.619200943953, 6759.425448836842, 6761.763338283149, 6766.560173588713, 6767.390934815866, 6793.490488213379, 4726.0, 4850.223964165734, 4969.1800852859415, 4981.825636102737, 4991.450940396553, 4924.236743304794, 4950.504949505039, 4976.253561965716, 4999.675021123633, 5000.624953128512, 4953.380827396575, 4957.281194226835, 4967.726775027372, 4968.6025117990475, 4993.325901003373, 4949.406071271453, 4953.455119936804, 4958.082754690357, 4969.602431805465, 4986.027724593706, 4110.815013324408, 4216.704830661855, 4225.197212529641, 4277.615014648665, 4294.699371044028, 6468.547201695883, 6478.54650174488, 6496.610203387764, 6509.828230918432, 6519.152510173647, 5921.348651648358, 5923.08192230205, 5938.703064846741, 5939.881202375971, 5947.851303717398, 7010.684519196649, 7269.673704414589, 7284.599347035911, 7285.125784905792, 7304.415646748301, 4793.784279707422, 4795.496472870368, 4802.4237091548885, 4806.086843499724, 4812.230043193107, 6138.47822935051, 7735.419843511703, 7748.883766743504, 7760.495567788075, 7784.455088143832, 4751.097291514601, 4888.315635810918, 4896.11869863428, 4901.730404827768, 4903.092927808367, 3870.3807390817333, 4952.158133117378, 4998.175301075282, 4999.725015124131, 5000.1749711297225, 5913.201717768132, 5915.260592425947, 5932.19915311436, 5937.079752638348, 5939.346671866091, 7324.0, 7324.267573242633, 7325.340719335285, 7336.193018767931, 7347.155077166194, 1665.100845543393, 1711.4951089428648, 1714.7427885817228, 1721.0792226158944, 1723.5001849463765, 1042.452712326035, 1079.09895237476, 1118.1446193661855, 1143.9256448330832, 1150.3787954504473, 6120.387961203933, 6468.191476065492, 6771.762988295386, 6806.217285012287, 6945.79162625112, 7637.13607397226, 7663.386929045774, 7684.346830519468, 7696.4227682924, 7816.06207255133, 6081.209442772411, 6556.967215163989, 6905.447564194953, 6924.3421874921805, 6950.0, 3905.3946638271113, 4040.4343391925154, 4047.777372244555, 4063.898402539901, 4071.2875246832277, 7245.5652660840515, 7996.360291176692, 7998.600069996593, 8014.679412823539, 8018.438709290411, 7557.848843023109, 7877.818327250959, 7893.684252629945, 7899.644515996794, 7934.523928564305, 7972.6412311444965, 7972.960135199287, 7978.640961156878, 7991.200879912079, 8003.079645840803, 7620.504667196615, 7623.390128789572, 7634.656440460081, 7637.809054773453, 7639.809004774925, 7270.054892863894, 7477.027986361738, 7489.775306740807, 7543.245675432413, 7570.697172113274, 7979.241972012649, 7990.121086680577, 8010.439269251096, 8023.398245131521, 8025.9598702006115, 4681.368015318025, 4682.41469816273, 4739.218029025173, 4742.1227072991605, 4743.264793956942, 7406.740764073232, 7575.166731659403, 7582.128055273714, 7595.430342724429, 7604.277593628596, 7304.890426643498, 7319.707211711472, 7321.633918303957, 7325.890111648223, 7334.743283985035, 5982.252218472691, 7102.289771022856, 7317.012203352479, 7317.414606831547, 7350.77947661571, 6419.807405777834, 6580.7496575650475, 7113.0753002109395, 7122.18094919091, 7140.571565705866, 6997.440204783503, 7119.85760284781, 7257.149426896108, 7281.308275713799, 7344.081989751281, 5861.443162899518, 7162.104736907887, 7206.351428371262, 7207.459440541876, 7209.062821833338], "unit": "score", "name": "prototype.html", "value": 5318.116117868748}, {"lowerIsBetter": false, "replicates": [674.5783885071829, 710.5203987308565, 713.5575942915393, 713.9000539924411, 724.8332883436808, 14088.859111408883, 14845.851541484582, 15211.46759863405, 15215.847841521581, 15860.52418427449, 15312.846871531281, 15470.303836327392, 15476.458323958665, 15579.922100389482, 15619.0, 864.5633954852791, 867.9652813887437, 877.9078196789341, 880.8238352329528, 882.6160620130232, 882.9293656507464, 885.8538341173698, 886.0961818944672, 886.8315020146184, 887.0818702642766, 924.2467389077914, 929.9395539289925, 931.0596297739264, 931.0735817861238, 931.1340453378356, 771.3674786674928, 901.7565257380503, 917.6696389299847, 925.4354843545466, 927.6104036304769, 668.8394785251553, 673.8551211489553, 682.1370965728357, 682.2086379799409, 689.8240948558085, 12257.264564126091, 15047.924760376238, 15073.170975596338, 15134.318955647022, 15162.0, 12350.876491235062, 12542.498300067986, 12637.0, 12825.16636418639, 12844.678883027906, 9889.604415823358, 9961.45212013339, 10041.096301332915, 10069.244806639457, 10586.735331616694, 3505.263894582141, 3562.0, 3579.7113039305827, 3626.1659818241687, 3747.419150031722, 79988.0, 80504.0, 81665.18334816635, 89788.10211897863, 90831.09168908292, 9654.324197306121, 9982.35114717541, 10100.898991009995, 10108.39349639024, 10416.531256093494, 21857.0, 22149.557008859734, 22168.224112155996, 22178.44553886166, 22306.776932230794, 7630.351420129351, 7686.730964416219, 7720.575368354795, 7775.5723435210475, 7793.2596403341595, 4047.1500984792933, 4128.1330920507025, 4140.565240649748, 4142.420061191436, 4160.313548264502, 3490.982545087258, 3518.9120271993406, 3533.116720819795, 3538.0, 3541.061618671054, 634.7365843175123, 647.9028145778171, 652.6345246661884, 670.7484693240035, 673.7069374821968, 503.3129777853204, 543.3615501785387, 598.9341172471024, 638.581728967527, 639.7500696461962, 8303.169683031769, 8555.443896146855, 8684.131586841266, 8839.248663863644, 8869.866951995726, 565.6492974355925, 595.7944509144338, 608.5223099866672, 618.8767387192231, 620.4292051312804, 4035.9798201009394, 4046.8988275293354, 4119.505659320901, 4334.696571239983, 4412.757298348557, 88344.11655883359, 89789.0, 92168.0, 100164.0, 100760.99239007516, 77731.22268777352, 77789.61105194438, 81588.0, 81953.59023204965, 83486.58256708678, 66755.664886702, 67831.66084169646, 71179.28820711726, 71608.64195678988, 71917.28082719211, 8045.436819422584, 8861.955690221508, 9142.268618510636, 9178.990311065643, 9190.218831399407, 51871.2219316703, 52997.0, 53488.73255633697, 54091.18863216976, 54466.0, 71625.0, 71903.28096718965, 72451.63774181095, 73247.0, 74138.62930685312, 10044.347117437343, 10155.543000564845, 10591.576336946744, 10959.301308297227, 11003.61487347939, 11785.292882427082, 11935.462904169506, 12339.07456940715, 12359.134860559674, 12410.255384676948, 11124.332540047622, 11397.886021140013, 11445.370504622326, 11771.23486973344, 12022.218555793845, 9896.703098907044, 11036.11711063129, 11472.770544589228, 11871.0, 12339.69150771238, 11309.886901130883, 11751.823722643996, 11763.353015584225, 11780.0, 12305.44625491873, 9359.812803743751, 9394.530273486162, 9713.951430242803, 9808.460534670661, 9940.005999400002, 9304.95347523258, 9865.210783137189, 10062.39625622465, 10086.041826026516, 10106.494675266355], "unit": "score", "name": "yui.html", "value": 7020.738217587753}], "name": "dromaeo_css", "value": 7528.805767231553}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [117.0, 107.0, 114.0, 113.0, 115.0, 126.0, 114.0, 113.0, 116.0, 115.0], "unit": "score", "name": "ai-astar", "value": 115.0}, {"lowerIsBetter": true, "replicates": [154.0, 122.0, 148.0, 155.0, 119.0, 181.0, 165.0, 113.0, 190.0, 156.0], "unit": "score", "name": "audio-beat-detection", "value": 150.3}, {"lowerIsBetter": true, "replicates": [193.0, 239.0, 262.0, 213.0, 207.0, 199.0, 242.0, 251.0, 203.0, 197.0], "unit": "score", "name": "audio-dft", "value": 220.6}, {"lowerIsBetter": true, "replicates": [82.0, 72.0, 73.0, 144.0, 84.0, 86.0, 74.0, 59.0, 88.0, 58.0], "unit": "score", "name": "audio-fft", "value": 82.0}, {"lowerIsBetter": true, "replicates": [81.0, 88.0, 118.0, 80.0, 80.0, 82.0, 120.0, 123.0, 120.0, 103.0], "unit": "score", "name": "audio-oscillator", "value": 99.5}, {"lowerIsBetter": true, "replicates": [88.0, 95.0, 86.0, 93.0, 88.0, 94.0, 86.0, 94.0, 88.0, 95.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.7}, {"lowerIsBetter": true, "replicates": [95.0, 96.0, 97.0, 129.0, 107.0, 152.0, 154.0, 94.0, 98.0, 106.0], "unit": "score", "name": "imaging-darkroom", "value": 112.8}, {"lowerIsBetter": true, "replicates": [91.0, 96.0, 93.0, 91.0, 93.0, 97.0, 93.0, 95.0, 93.0, 110.0], "unit": "score", "name": "imaging-desaturate", "value": 95.2}, {"lowerIsBetter": true, "replicates": [56.0, 56.0, 57.0, 55.0, 58.0, 55.0, 58.0, 64.0, 58.0, 59.0], "unit": "score", "name": "json-parse-financial", "value": 57.6}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 63.0, 71.0, 65.0, 66.0, 67.0, 65.0, 71.0, 67.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 67.0}, {"lowerIsBetter": true, "replicates": [88.0, 86.0, 86.0, 80.0, 102.0, 84.0, 83.0, 83.0, 87.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.5}, {"lowerIsBetter": true, "replicates": [125.0, 126.0, 124.0, 141.0, 132.0, 135.0, 130.0, 117.0, 115.0, 115.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 126.0}, {"lowerIsBetter": true, "replicates": [176.0, 161.0, 141.0, 145.0, 145.0, 144.0, 144.0, 141.0, 131.0, 137.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 146.5}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 63.0, 66.0, 70.0, 68.0, 69.0, 73.0, 68.0, 57.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 66.9}], "name": "kraken", "value": 1516.6000000000001}]} 05:18:54 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1516.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7528.81"}}} 05:18:54 INFO - Return code: 0 05:18:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 05:18:54 ERROR - # TBPL SUCCESS # 05:18:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:18:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:18:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:18:54 INFO - 2016-02-18 05:18:54.857 screenresolution[2000:19734] starting screenresolution argv=screenresolution get 05:18:54 INFO - 2016-02-18 05:18:54.860 screenresolution[2000:19734] Display 0: 1600x1200x32@60 05:18:54 INFO - 2016-02-18 05:18:54.865 screenresolution[2001:19737] starting screenresolution argv=screenresolution list 05:18:54 INFO - Available Modes on Display 0 05:18:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:18:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:18:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:18:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:18:55 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:18:55 INFO - Intel Iris: 05:18:55 INFO - Chipset Model: Intel Iris 05:18:55 INFO - Type: GPU 05:18:55 INFO - Bus: Built-In 05:18:55 INFO - VRAM (Dynamic, Max): 1536 MB 05:18:55 INFO - Vendor: Intel (0x8086) 05:18:55 INFO - Device ID: 0x0a2e 05:18:55 INFO - Revision ID: 0x0009 05:18:55 INFO - Displays: 05:18:55 INFO - Display: 05:18:55 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:18:55 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:18:55 INFO - Display Serial Number: 1600x1200 60 05:18:55 INFO - Main Display: Yes 05:18:55 INFO - Mirror: Off 05:18:55 INFO - Online: Yes 05:18:55 INFO - Rotation: Supported 05:18:55 INFO - Return code: 0 05:18:55 INFO - Running post-action listener: _resource_record_post_action 05:18:55 INFO - Running post-run listener: _resource_record_post_run 05:18:56 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 8192; Write bytes: 708287488; Read time: 1; Write time: 1928 05:18:56 INFO - install - Wall time: 34s; CPU: 55.0%; Read bytes: 401428992; Write bytes: 395727360; Read time: 29973; Write time: 687 05:18:56 INFO - run-tests - Wall time: 1172s; CPU: 54.0%; Read bytes: 8192; Write bytes: 300997120; Read time: 1; Write time: 1200 05:18:56 INFO - Running post-run listener: _upload_blobber_files 05:18:56 INFO - Blob upload gear active. 05:18:56 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:18:56 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 05:18:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:18:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:18:56 INFO - (blobuploader) - INFO - Open directory for files ... 05:18:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 05:18:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 05:18:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:57 INFO - (blobuploader) - INFO - Done attempting. 05:18:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 05:18:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:18:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:18:58 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 05:18:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:18:58 INFO - (blobuploader) - INFO - Done attempting. 05:18:58 INFO - (blobuploader) - INFO - Iteration through files over. 05:18:58 INFO - Return code: 0 05:18:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:18:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:18:58 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4730c0626a58e6d315209cd09aad33a17f3022fda6bf5fdafcee90b6553da2c7976042d59f5fd371129d66832d715260e5536aef58192b69a7d13e53276a3e9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44bb539ce17414f5fd7ae554e912870160e08c6f72571d215a2eccfa23d56c92127fcafc1d5ae21de91d1ba862bd24d77e7df646f1c9df106e4f318cd357ce06"} 05:18:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:18:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:18:58 INFO - Contents: 05:18:58 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4730c0626a58e6d315209cd09aad33a17f3022fda6bf5fdafcee90b6553da2c7976042d59f5fd371129d66832d715260e5536aef58192b69a7d13e53276a3e9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44bb539ce17414f5fd7ae554e912870160e08c6f72571d215a2eccfa23d56c92127fcafc1d5ae21de91d1ba862bd24d77e7df646f1c9df106e4f318cd357ce06"} 05:18:58 INFO - Running post-run listener: copy_logs_to_upload_dir 05:18:58 INFO - Copying logs to upload dir... 05:18:58 INFO - mkdir: /builds/slave/test/build/upload/logs 05:18:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.673009 ========= master_lag: 2.02 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 2 secs) (at 2016-02-18 05:19:00.705867) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 05:19:00.709691) ========= 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.MR0RRcPvFW/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.WmtgVpk4ly/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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/Firefox/sha512/4730c0626a58e6d315209cd09aad33a17f3022fda6bf5fdafcee90b6553da2c7976042d59f5fd371129d66832d715260e5536aef58192b69a7d13e53276a3e9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44bb539ce17414f5fd7ae554e912870160e08c6f72571d215a2eccfa23d56c92127fcafc1d5ae21de91d1ba862bd24d77e7df646f1c9df106e4f318cd357ce06"} build_url:https://queue.taskcluster.net/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011263 build_url: 'https://queue.taskcluster.net/v1/task/RCIJYmUCSL-n5LJM5GYyLQ/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/4730c0626a58e6d315209cd09aad33a17f3022fda6bf5fdafcee90b6553da2c7976042d59f5fd371129d66832d715260e5536aef58192b69a7d13e53276a3e9c", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/44bb539ce17414f5fd7ae554e912870160e08c6f72571d215a2eccfa23d56c92127fcafc1d5ae21de91d1ba862bd24d77e7df646f1c9df106e4f318cd357ce06"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-18 05:19:00.747859) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:19:00.748193) ========= 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.MR0RRcPvFW/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.WmtgVpk4ly/Listeners TMPDIR=/var/folders/gq/h8xl864x5nj_24yktmm7rk9000000w/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.005413 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-18 05:19:00.798853) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 05:19:00.799161) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-18 05:19:00.799589) ========= ========= Total master_lag: 2.27 =========