builder: mozilla-central_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0057 starttime: 1456251401.64 results: success (0) buildid: 20160223030304 builduid: d32a9238d9644683b7ce63ab094970b9 revision: 789a12291942763bc1e3a89f97e0b82dc1c9d00b ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:41.640572) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:41.641050) ========= ========= Started set props: basedir (results: 0, elapsed: 8 secs) (at 2016-02-23 10:16:41.641392) ========= 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.ZKCToJsGnO/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.w8g0hMwmks/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.005821 basedir: '/builds/slave/test' ========= master_lag: 8.88 ========= ========= Finished set props: basedir (results: 0, elapsed: 8 secs) (at 2016-02-23 10:16:50.523632) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-02-23 10:16:50.523999) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 2 secs) (at 2016-02-23 10:16:53.302598) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2016-02-23 10:16:53.302908) ========= 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.ZKCToJsGnO/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.w8g0hMwmks/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.005473 ========= master_lag: 6.13 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 6 secs) (at 2016-02-23 10:16:59.436370) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:59.436703) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-23 10:16:59.439545) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 10:16:59.439888) ========= 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.ZKCToJsGnO/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.w8g0hMwmks/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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-23 10:17:00-- 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% 38.2M=0s 2016-02-23 10:17:00 (38.2 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.179658 ========= master_lag: 1.25 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 10:17:00.873835) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-02-23 10:17:00.874166) ========= 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.ZKCToJsGnO/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.w8g0hMwmks/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.019711 ========= master_lag: 4.43 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 4 secs) (at 2016-02-23 10:17:05.319760) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 10:17:05.323249) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 789a12291942763bc1e3a89f97e0b82dc1c9d00b --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 789a12291942763bc1e3a89f97e0b82dc1c9d00b --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZKCToJsGnO/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.w8g0hMwmks/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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-23 10:17:05,410 truncating revision to first 12 chars 2016-02-23 10:17:05,410 Setting DEBUG logging. 2016-02-23 10:17:05,410 attempt 1/10 2016-02-23 10:17:05,410 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/789a12291942?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-23 10:17:06,042 unpacking tar archive at: mozilla-central-789a12291942/testing/mozharness/ program finished with exit code 0 elapsedTime=0.871271 ========= master_lag: 0.92 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-02-23 10:17:07.118029) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 10:17:07.118449) ========= echo 789a12291942763bc1e3a89f97e0b82dc1c9d00b in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'789a12291942763bc1e3a89f97e0b82dc1c9d00b'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ZKCToJsGnO/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.w8g0hMwmks/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 789a12291942763bc1e3a89f97e0b82dc1c9d00b program finished with exit code 0 elapsedTime=0.005365 script_repo_revision: '789a12291942763bc1e3a89f97e0b82dc1c9d00b' ========= master_lag: 0.02 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-23 10:17:07.142960) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 10:17:07.143321) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-23 10:17:07.157268) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-23 10:17:07.158001) ========= /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.ZKCToJsGnO/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.w8g0hMwmks/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 10:17:07 INFO - MultiFileLogger online at 20160223 10:17:07 in /builds/slave/test 10:17:07 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 10:17:07 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 10:17:07 INFO - {'append_to_log': False, 10:17:07 INFO - 'base_work_dir': '/builds/slave/test', 10:17:07 INFO - 'blob_upload_branch': 'Firefox', 10:17:07 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 10:17:07 INFO - 'branch': 'Firefox', 10:17:07 INFO - 'buildbot_json_path': 'buildprops.json', 10:17:07 INFO - 'config_files': ('talos/mac_config.py',), 10:17:07 INFO - 'default_actions': ('clobber', 10:17:07 INFO - 'read-buildbot-config', 10:17:07 INFO - 'download-and-extract', 10:17:07 INFO - 'populate-webroot', 10:17:07 INFO - 'create-virtualenv', 10:17:07 INFO - 'install', 10:17:07 INFO - 'run-tests'), 10:17:07 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 10:17:07 INFO - 'download_minidump_stackwalk': True, 10:17:07 INFO - 'download_symbols': 'ondemand', 10:17:07 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 10:17:07 INFO - 'tooltool.py': '/tools/tooltool.py', 10:17:07 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 10:17:07 INFO - '/tools/misc-python/virtualenv.py')}, 10:17:07 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 10:17:07 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 10:17:07 INFO - 'installer_path': 'installer.exe', 10:17:07 INFO - 'log_level': 'info', 10:17:07 INFO - 'log_name': 'talos', 10:17:07 INFO - 'log_to_console': True, 10:17:07 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 10:17:07 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 10:17:07 INFO - 'opt_config_files': (), 10:17:07 INFO - 'pip_index': False, 10:17:07 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:17:07 INFO - 'cmd': ('bash', 10:17:07 INFO - '-c', 10:17:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:17:07 INFO - 'enabled': True, 10:17:07 INFO - 'halt_on_failure': False, 10:17:07 INFO - 'name': 'check_screen_resolution'},), 10:17:07 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 10:17:07 INFO - 'cmd': ('bash', 10:17:07 INFO - '-c', 10:17:07 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 10:17:07 INFO - 'enabled': True, 10:17:07 INFO - 'halt_on_failure': False, 10:17:07 INFO - 'name': 'check_screen_resolution'},), 10:17:07 INFO - 'run_cmd_checks_enabled': True, 10:17:07 INFO - 'sps_profile': False, 10:17:07 INFO - 'sps_profile_interval': 0, 10:17:07 INFO - 'suite': 'dromaeojs-e10s', 10:17:07 INFO - 'system_bits': '32', 10:17:07 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 10:17:07 INFO - 'title': 't-yosemite-r7-0057', 10:17:07 INFO - 'tooltool_cache': '/builds/tooltool_cache', 10:17:07 INFO - 'use_talos_json': True, 10:17:07 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 10:17:07 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 10:17:07 INFO - 'work_dir': 'build'} 10:17:07 INFO - ##### 10:17:07 INFO - ##### Running clobber step. 10:17:07 INFO - ##### 10:17:07 INFO - Running pre-action listener: _resource_record_pre_action 10:17:07 INFO - Running main action method: clobber 10:17:07 INFO - rmtree: /builds/slave/test/build 10:17:07 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 10:17:08 INFO - Running post-action listener: _resource_record_post_action 10:17:08 INFO - ##### 10:17:08 INFO - ##### Running read-buildbot-config step. 10:17:08 INFO - ##### 10:17:08 INFO - Running pre-action listener: _resource_record_pre_action 10:17:08 INFO - Running main action method: read_buildbot_config 10:17:08 INFO - Using buildbot properties: 10:17:08 INFO - { 10:17:08 INFO - "project": "", 10:17:08 INFO - "product": "firefox", 10:17:08 INFO - "script_repo_revision": "production", 10:17:08 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs-e10s", 10:17:08 INFO - "repository": "", 10:17:08 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs-e10s", 10:17:08 INFO - "buildid": "20160223030304", 10:17:08 INFO - "stage_platform": "macosx64", 10:17:08 INFO - "basedir": "/builds/slave/test", 10:17:08 INFO - "nightly_build": "True", 10:17:08 INFO - "buildnumber": 119, 10:17:08 INFO - "slavename": "t-yosemite-r7-0057", 10:17:08 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 10:17:08 INFO - "platform": "yosemite_r7", 10:17:08 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 10:17:08 INFO - "branch": "mozilla-central", 10:17:08 INFO - "repo_path": "mozilla-central", 10:17:08 INFO - "revision": "789a12291942763bc1e3a89f97e0b82dc1c9d00b", 10:17:08 INFO - "pgo_build": "False", 10:17:08 INFO - "builduid": "d32a9238d9644683b7ce63ab094970b9", 10:17:08 INFO - "slavebuilddir": "test" 10:17:08 INFO - } 10:17:08 INFO - Found installer url https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 10:17:08 INFO - Running post-action listener: _resource_record_post_action 10:17:08 INFO - ##### 10:17:08 INFO - ##### Running download-and-extract step. 10:17:08 INFO - ##### 10:17:08 INFO - Running pre-action listener: _resource_record_pre_action 10:17:08 INFO - Running main action method: download_and_extract 10:17:08 INFO - mkdir: /builds/slave/test/build/tests 10:17:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:08 INFO - https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 10:17:08 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/test_packages.json 10:17:08 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/test_packages.json 10:17:08 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 10:17:08 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 10:17:09 INFO - Downloaded 1277 bytes. 10:17:09 INFO - Reading from file /builds/slave/test/build/test_packages.json 10:17:09 INFO - Using the following test package requirements: 10:17:09 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:17:09 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:17:09 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 10:17:09 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:17:09 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 10:17:09 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:17:09 INFO - u'jsshell-mac.zip'], 10:17:09 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:17:09 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 10:17:09 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:17:09 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:17:09 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 10:17:09 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:17:09 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 10:17:09 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:17:09 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 10:17:09 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 10:17:09 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 10:17:09 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 10:17:09 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 10:17:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:09 INFO - https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:17:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:17:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:17:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/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 10:17:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/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 10:17:11 INFO - Downloaded 17825545 bytes. 10:17:11 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'] 10:17:11 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 10:17:14 INFO - Return code: 0 10:17:14 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 10:17:14 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')]} 10:17:14 INFO - https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 10:17:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:17:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 10:17:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/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 10:17:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/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 10:17:15 INFO - Downloaded 17825545 bytes. 10:17:15 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'] 10:17:15 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 10:17:18 INFO - Return code: 0 10:17:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:18 INFO - https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 10:17:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:17:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 10:17:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/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 10:17:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/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 10:17:20 INFO - Downloaded 10707015 bytes. 10:17:20 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'] 10:17:20 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 10:17:20 INFO - Return code: 0 10:17:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:20 INFO - https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 10:17:20 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:17:20 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:17:20 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 10:17:20 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/WI-so8rzQPOEOPkkRb3DqA/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 10:17:23 INFO - Downloaded 111375537 bytes. 10:17:23 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:17:23 INFO - mkdir: /builds/slave/test/properties 10:17:23 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 10:17:23 INFO - Writing to file /builds/slave/test/properties/build_url 10:17:23 INFO - Contents: 10:17:23 INFO - build_url:https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 10:17:25 INFO - Running post-action listener: _resource_record_post_action 10:17:25 INFO - Running post-action listener: set_extra_try_arguments 10:17:25 INFO - ##### 10:17:25 INFO - ##### Running populate-webroot step. 10:17:25 INFO - ##### 10:17:25 INFO - Running pre-action listener: _resource_record_pre_action 10:17:25 INFO - Running main action method: populate_webroot 10:17:25 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 10:17:25 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 10:17:25 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 10:17:25 INFO - '--tppagecycles', 10:17:25 INFO - '7'], 10:17:25 INFO - 'tests': ['tsvgm']}}, 10:17:25 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 10:17:25 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 10:17:25 INFO - 'tests': ['tresize', 'tcanvasmark']}, 10:17:25 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 10:17:25 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 10:17:25 INFO - 'tests': ['dromaeo_css', 'kraken']}, 10:17:25 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:25 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:25 INFO - 'talos_options': ['--e10s'], 10:17:25 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 10:17:25 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:25 INFO - 'tests': ['damp', 'tps']}, 10:17:25 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:25 INFO - 'talos_options': ['--e10s'], 10:17:25 INFO - 'tests': ['damp', 'tps']}, 10:17:25 INFO - 'g3': {'tests': ['dromaeo_dom']}, 10:17:25 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 10:17:25 INFO - 'other': {'tests': ['a11yr', 10:17:25 INFO - 'ts_paint', 10:17:25 INFO - 'tpaint', 10:17:25 INFO - 'sessionrestore', 10:17:25 INFO - 'sessionrestore_no_auto_restore']}, 10:17:25 INFO - 'other-e10s': {'talos_options': ['--e10s'], 10:17:25 INFO - 'tests': ['a11yr', 10:17:25 INFO - 'ts_paint', 10:17:25 INFO - 'tpaint', 10:17:25 INFO - 'sessionrestore', 10:17:25 INFO - 'sessionrestore_no_auto_restore']}, 10:17:25 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 10:17:25 INFO - 'tests': ['a11yr', 10:17:25 INFO - 'ts_paint', 10:17:25 INFO - 'tpaint', 10:17:25 INFO - 'sessionrestore', 10:17:25 INFO - 'sessionrestore_no_auto_restore']}, 10:17:25 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 10:17:25 INFO - 'tests': ['a11yr', 10:17:25 INFO - 'ts_paint', 10:17:25 INFO - 'tpaint', 10:17:25 INFO - 'sessionrestore', 10:17:25 INFO - 'sessionrestore_no_auto_restore']}, 10:17:25 INFO - 'other_l64': {'tests': ['a11yr', 10:17:25 INFO - 'ts_paint', 10:17:25 INFO - 'tpaint', 10:17:25 INFO - 'sessionrestore', 10:17:25 INFO - 'sessionrestore_no_auto_restore']}, 10:17:25 INFO - 'other_nol64': {'tests': ['a11yr', 10:17:25 INFO - 'ts_paint', 10:17:25 INFO - 'tpaint', 10:17:25 INFO - 'sessionrestore', 10:17:25 INFO - 'sessionrestore_no_auto_restore']}, 10:17:25 INFO - 'svgr': {'tests': ['tsvgx', 10:17:25 INFO - 'tsvgr_opacity', 10:17:25 INFO - 'tart', 10:17:25 INFO - 'tscrollx', 10:17:25 INFO - 'cart']}, 10:17:25 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 10:17:25 INFO - 'tests': ['tsvgx', 10:17:25 INFO - 'tsvgr_opacity', 10:17:25 INFO - 'tart', 10:17:25 INFO - 'tscrollx', 10:17:25 INFO - 'cart']}, 10:17:25 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:25 INFO - 'tests': ['tp5o']}, 10:17:25 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:25 INFO - 'talos_options': ['--e10s'], 10:17:25 INFO - 'tests': ['tp5o']}, 10:17:25 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:25 INFO - 'talos_options': ['--xperf_path', 10:17:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:25 INFO - 'tests': ['tp5n']}, 10:17:25 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 10:17:25 INFO - 'talos_options': ['--e10s', 10:17:25 INFO - '--xperf_path', 10:17:25 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 10:17:25 INFO - 'tests': ['tp5n']}}, 10:17:25 INFO - 'talos.zip': {'path': '', 10:17:25 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 10:17:25 INFO - Running post-action listener: _resource_record_post_action 10:17:25 INFO - ##### 10:17:25 INFO - ##### Running create-virtualenv step. 10:17:25 INFO - ##### 10:17:25 INFO - Running pre-action listener: _resource_record_pre_action 10:17:25 INFO - Running main action method: create_virtualenv 10:17:25 INFO - Creating virtualenv /builds/slave/test/build/venv 10:17:25 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 10:17:25 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 10:17:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 10:17:25 INFO - Using real prefix '/tools/python27' 10:17:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 10:17:25 INFO - Installing distribute.............................................................................................................................................................................................done. 10:17:28 INFO - Installing pip.................done. 10:17:28 INFO - Return code: 0 10:17:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 10:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10b850a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc28a5949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f4d30>, '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 0x10b518db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ebb20>, '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.ZKCToJsGnO/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.w8g0hMwmks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 10:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 10:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 10:17:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZKCToJsGnO/Render', 10:17:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:28 INFO - 'HOME': '/Users/cltbld', 10:17:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:28 INFO - 'LOGNAME': 'cltbld', 10:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:28 INFO - 'MOZ_NO_REMOTE': '1', 10:17:28 INFO - 'NO_EM_RESTART': '1', 10:17:28 INFO - 'PAGER': '/bin/cat', 10:17:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:28 INFO - 'PWD': '/builds/slave/test', 10:17:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:28 INFO - 'SHELL': '/bin/bash', 10:17:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8g0hMwmks/Listeners', 10:17:28 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 10:17:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:28 INFO - 'USER': 'cltbld', 10:17:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:28 INFO - 'XPC_FLAGS': '0x0', 10:17:28 INFO - 'XPC_SERVICE_NAME': '0', 10:17:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:29 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 10:17:29 INFO - Cleaning up... 10:17:29 INFO - Return code: 0 10:17:29 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 10:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10b850a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc28a5949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f4d30>, '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 0x10b518db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ebb20>, '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.ZKCToJsGnO/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.w8g0hMwmks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 10:17:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 10:17:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 10:17:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZKCToJsGnO/Render', 10:17:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:29 INFO - 'HOME': '/Users/cltbld', 10:17:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:29 INFO - 'LOGNAME': 'cltbld', 10:17:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:29 INFO - 'MOZ_NO_REMOTE': '1', 10:17:29 INFO - 'NO_EM_RESTART': '1', 10:17:29 INFO - 'PAGER': '/bin/cat', 10:17:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:29 INFO - 'PWD': '/builds/slave/test', 10:17:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:29 INFO - 'SHELL': '/bin/bash', 10:17:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8g0hMwmks/Listeners', 10:17:29 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 10:17:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:29 INFO - 'USER': 'cltbld', 10:17:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:29 INFO - 'XPC_FLAGS': '0x0', 10:17:29 INFO - 'XPC_SERVICE_NAME': '0', 10:17:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:29 INFO - Downloading/unpacking psutil>=0.7.1 10:17: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 10:17: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 10:17: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 10:17: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 10:17: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 10:17: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 10:17:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 10:17:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:32 INFO - Installing collected packages: psutil 10:17:32 INFO - Running setup.py install for psutil 10:17:32 INFO - building 'psutil._psutil_osx' extension 10:17:32 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 10:17:32 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 10:17:32 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 10:17:32 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 10:17:32 INFO - building 'psutil._psutil_posix' extension 10:17:32 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 10:17:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 10:17:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 10:17:32 INFO - ^ 10:17:32 INFO - 1 warning generated. 10:17:32 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 10:17:32 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 10:17:32 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 10:17:32 INFO - Successfully installed psutil 10:17:32 INFO - Cleaning up... 10:17:33 INFO - Return code: 0 10:17:33 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 10:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:33 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 0x10b850a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc28a5949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f4d30>, '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 0x10b518db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ebb20>, '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.ZKCToJsGnO/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.w8g0hMwmks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 10:17:33 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 10:17:33 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 10:17:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZKCToJsGnO/Render', 10:17:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:33 INFO - 'HOME': '/Users/cltbld', 10:17:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:33 INFO - 'LOGNAME': 'cltbld', 10:17:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:33 INFO - 'MOZ_NO_REMOTE': '1', 10:17:33 INFO - 'NO_EM_RESTART': '1', 10:17:33 INFO - 'PAGER': '/bin/cat', 10:17:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:33 INFO - 'PWD': '/builds/slave/test', 10:17:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:33 INFO - 'SHELL': '/bin/bash', 10:17:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8g0hMwmks/Listeners', 10:17:33 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 10:17:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:33 INFO - 'USER': 'cltbld', 10:17:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:33 INFO - 'XPC_FLAGS': '0x0', 10:17:33 INFO - 'XPC_SERVICE_NAME': '0', 10:17:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:33 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 10:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:35 INFO - Downloading mozsystemmonitor-0.0.tar.gz 10:17:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 10:17:35 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 10:17:35 INFO - Installing collected packages: mozsystemmonitor 10:17:35 INFO - Running setup.py install for mozsystemmonitor 10:17:35 INFO - Successfully installed mozsystemmonitor 10:17:35 INFO - Cleaning up... 10:17:35 INFO - Return code: 0 10:17:35 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17: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')]} 10:17:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:35 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 0x10b850a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc28a5949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f4d30>, '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 0x10b518db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ebb20>, '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.ZKCToJsGnO/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.w8g0hMwmks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 10:17:35 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 10:17:35 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 10:17:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZKCToJsGnO/Render', 10:17:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:35 INFO - 'HOME': '/Users/cltbld', 10:17:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:35 INFO - 'LOGNAME': 'cltbld', 10:17:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:35 INFO - 'MOZ_NO_REMOTE': '1', 10:17:35 INFO - 'NO_EM_RESTART': '1', 10:17:35 INFO - 'PAGER': '/bin/cat', 10:17:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:35 INFO - 'PWD': '/builds/slave/test', 10:17:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:35 INFO - 'SHELL': '/bin/bash', 10:17:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8g0hMwmks/Listeners', 10:17:35 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 10:17:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:35 INFO - 'USER': 'cltbld', 10:17:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:35 INFO - 'XPC_FLAGS': '0x0', 10:17:35 INFO - 'XPC_SERVICE_NAME': '0', 10:17:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:36 INFO - Downloading/unpacking blobuploader==1.2.4 10:17:36 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 10:17:36 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 10:17:36 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 10:17:36 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 10:17:36 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 10:17:36 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 10:17:38 INFO - Downloading blobuploader-1.2.4.tar.gz 10:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 10:17:38 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 10:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 10:17:39 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 10:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:39 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:39 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:39 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:39 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:39 INFO - Downloading docopt-0.6.1.tar.gz 10:17:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 10:17:39 INFO - Installing collected packages: blobuploader, requests, docopt 10:17:39 INFO - Running setup.py install for blobuploader 10:17:39 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 10:17:39 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 10:17:39 INFO - Running setup.py install for requests 10:17:40 INFO - Running setup.py install for docopt 10:17:40 INFO - Successfully installed blobuploader requests docopt 10:17:40 INFO - Cleaning up... 10:17:40 INFO - Return code: 0 10:17:40 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17: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')]} 10:17:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17: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')]} 10:17:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:40 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 0x10b850a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc28a5949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f4d30>, '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 0x10b518db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ebb20>, '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.ZKCToJsGnO/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.w8g0hMwmks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 10:17:40 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 10:17:40 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 10:17:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZKCToJsGnO/Render', 10:17:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:40 INFO - 'HOME': '/Users/cltbld', 10:17:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:40 INFO - 'LOGNAME': 'cltbld', 10:17:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:40 INFO - 'MOZ_NO_REMOTE': '1', 10:17:40 INFO - 'NO_EM_RESTART': '1', 10:17:40 INFO - 'PAGER': '/bin/cat', 10:17:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:40 INFO - 'PWD': '/builds/slave/test', 10:17:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:40 INFO - 'SHELL': '/bin/bash', 10:17:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8g0hMwmks/Listeners', 10:17:40 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 10:17:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:40 INFO - 'USER': 'cltbld', 10:17:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:40 INFO - 'XPC_FLAGS': '0x0', 10:17:40 INFO - 'XPC_SERVICE_NAME': '0', 10:17:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:40 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-vDBLAg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:40 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-rHnIwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:40 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-EIWjQv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:41 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-ZDSZiW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:41 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-ha0rrS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:41 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-AE_AY5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:41 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-_gRa5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:41 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-tNLumy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:41 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-kmXLPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:41 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-Ekzu22-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:41 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-3P4RJC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:41 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-V2BAV6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:42 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-jqb8GS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:42 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-gbgmS_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:42 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-w1NMEw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:42 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-hq8wi0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:42 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:42 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-iDhhCX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:42 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 10:17:42 INFO - Running setup.py install for manifestparser 10:17:42 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 10:17:42 INFO - Running setup.py install for mozcrash 10:17:42 INFO - Running setup.py install for mozdebug 10:17:42 INFO - Running setup.py install for mozdevice 10:17:43 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 10:17:43 INFO - Installing dm script to /builds/slave/test/build/venv/bin 10:17:43 INFO - Running setup.py install for mozfile 10:17:43 INFO - Running setup.py install for mozhttpd 10:17:43 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 10:17:43 INFO - Running setup.py install for mozinfo 10:17:43 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 10:17:43 INFO - Running setup.py install for mozInstall 10:17:43 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 10:17:43 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 10:17:43 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 10:17:43 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 10:17:43 INFO - Running setup.py install for mozleak 10:17:43 INFO - Running setup.py install for mozlog 10:17:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Running setup.py install for moznetwork 10:17:44 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Running setup.py install for mozprocess 10:17:44 INFO - Running setup.py install for mozprofile 10:17:44 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Running setup.py install for mozrunner 10:17:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 10:17:44 INFO - Running setup.py install for mozscreenshot 10:17:44 INFO - Running setup.py install for moztest 10:17:44 INFO - Running setup.py install for mozversion 10:17:45 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 10:17:45 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 10:17:45 INFO - Cleaning up... 10:17:45 INFO - Return code: 0 10:17:45 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:45 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 0x10b850a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc28a5949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f4d30>, '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 0x10b518db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ebb20>, '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.ZKCToJsGnO/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.w8g0hMwmks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 10:17:45 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 10:17:45 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 10:17:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZKCToJsGnO/Render', 10:17:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:45 INFO - 'HOME': '/Users/cltbld', 10:17:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:45 INFO - 'LOGNAME': 'cltbld', 10:17:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:45 INFO - 'MOZ_NO_REMOTE': '1', 10:17:45 INFO - 'NO_EM_RESTART': '1', 10:17:45 INFO - 'PAGER': '/bin/cat', 10:17:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:45 INFO - 'PWD': '/builds/slave/test', 10:17:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:45 INFO - 'SHELL': '/bin/bash', 10:17:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8g0hMwmks/Listeners', 10:17:45 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 10:17:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:45 INFO - 'USER': 'cltbld', 10:17:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:45 INFO - 'XPC_FLAGS': '0x0', 10:17:45 INFO - 'XPC_SERVICE_NAME': '0', 10:17:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 10:17:45 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-DyEPT3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 10:17:45 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)) 10:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 10:17:45 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-xfoBjS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 10:17:45 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)) 10:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 10:17:45 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-A7RAfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 10:17:45 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)) 10:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 10:17:45 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-d9qH68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 10:17:45 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)) 10:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 10:17:45 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-lZloSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 10:17:45 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)) 10:17:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 10:17:45 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-XUXUUs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 10:17:46 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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 10:17:46 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-BBRr6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 10:17:46 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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 10:17:46 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-LPtnPk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 10:17:46 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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 10:17:46 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-xkcsKF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 10:17:46 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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 10:17:46 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-aX7tKU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 10:17:46 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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 10:17:46 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-8LiDYf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 10:17:46 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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 10:17:46 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-V9nNDB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 10:17:46 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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 10:17:46 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-MrgGPx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 10:17:46 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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 10:17:46 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-e4IWzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 10:17:46 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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:46 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-55ctfp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 10:17:46 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)) 10:17:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 10:17:46 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-SmuZHj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 10:17:47 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)) 10:17:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 10:17:47 INFO - Running setup.py (path:/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/pip-BefRQf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 10:17:47 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)) 10:17:47 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)) 10:17:47 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)) 10:17:47 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)) 10:17:47 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)) 10:17:47 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)) 10:17:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 10:17: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 10:17: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 10:17: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 10:17: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 10:17: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 10:17: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 10:17:49 INFO - Downloading blessings-1.6.tar.gz 10:17:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 10:17:49 INFO - Installing collected packages: blessings 10:17:49 INFO - Running setup.py install for blessings 10:17:49 INFO - Successfully installed blessings 10:17:49 INFO - Cleaning up... 10:17:49 INFO - Return code: 0 10:17:49 INFO - Done creating virtualenv /builds/slave/test/build/venv. 10:17:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:50 INFO - Reading from file tmpfile_stdout 10:17:50 INFO - Current package versions: 10:17:50 INFO - blessings == 1.6 10:17:50 INFO - blobuploader == 1.2.4 10:17:50 INFO - docopt == 0.6.1 10:17:50 INFO - manifestparser == 1.1 10:17:50 INFO - mozInstall == 1.12 10:17:50 INFO - mozcrash == 0.16 10:17:50 INFO - mozdebug == 0.1 10:17:50 INFO - mozdevice == 0.48 10:17:50 INFO - mozfile == 1.2 10:17:50 INFO - mozhttpd == 0.7 10:17:50 INFO - mozinfo == 0.9 10:17:50 INFO - mozleak == 0.1 10:17:50 INFO - mozlog == 3.1 10:17:50 INFO - moznetwork == 0.27 10:17:50 INFO - mozprocess == 0.22 10:17:50 INFO - mozprofile == 0.28 10:17:50 INFO - mozrunner == 6.11 10:17:50 INFO - mozscreenshot == 0.1 10:17:50 INFO - mozsystemmonitor == 0.0 10:17:50 INFO - moztest == 0.7 10:17:50 INFO - mozversion == 1.4 10:17:50 INFO - psutil == 3.1.1 10:17:50 INFO - requests == 1.2.3 10:17:50 INFO - wsgiref == 0.1.2 10:17:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 10:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:50 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 0x10b850a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc28a5949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f4d30>, '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 0x10b518db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ebb20>, '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.ZKCToJsGnO/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.w8g0hMwmks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 10:17:50 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 10:17:50 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 10:17:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZKCToJsGnO/Render', 10:17:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:50 INFO - 'HOME': '/Users/cltbld', 10:17:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:50 INFO - 'LOGNAME': 'cltbld', 10:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:50 INFO - 'MOZ_NO_REMOTE': '1', 10:17:50 INFO - 'NO_EM_RESTART': '1', 10:17:50 INFO - 'PAGER': '/bin/cat', 10:17:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:50 INFO - 'PWD': '/builds/slave/test', 10:17:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:50 INFO - 'SHELL': '/bin/bash', 10:17:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8g0hMwmks/Listeners', 10:17:50 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 10:17:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:50 INFO - 'USER': 'cltbld', 10:17:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:50 INFO - 'XPC_FLAGS': '0x0', 10:17:50 INFO - 'XPC_SERVICE_NAME': '0', 10:17:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:50 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)) 10:17:50 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)) 10:17:50 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)) 10:17:50 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)) 10:17:50 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)) 10:17:50 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)) 10:17:50 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)) 10:17:50 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)) 10:17:50 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)) 10:17:50 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)) 10:17:50 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)) 10:17:50 INFO - Cleaning up... 10:17:50 INFO - Return code: 0 10:17:50 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 10:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:50 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 0x10b850a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc28a5949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f4d30>, '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 0x10b518db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ebb20>, '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.ZKCToJsGnO/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.w8g0hMwmks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 10:17:50 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 10:17:50 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 10:17:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZKCToJsGnO/Render', 10:17:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:50 INFO - 'HOME': '/Users/cltbld', 10:17:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:50 INFO - 'LOGNAME': 'cltbld', 10:17:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:50 INFO - 'MOZ_NO_REMOTE': '1', 10:17:50 INFO - 'NO_EM_RESTART': '1', 10:17:50 INFO - 'PAGER': '/bin/cat', 10:17:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:50 INFO - 'PWD': '/builds/slave/test', 10:17:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:50 INFO - 'SHELL': '/bin/bash', 10:17:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8g0hMwmks/Listeners', 10:17:50 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 10:17:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:50 INFO - 'USER': 'cltbld', 10:17:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:50 INFO - 'XPC_FLAGS': '0x0', 10:17:50 INFO - 'XPC_SERVICE_NAME': '0', 10:17:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:50 INFO - Downloading/unpacking jsonschema 10:17:50 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 10:17:50 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 10:17:50 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 10:17:50 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 10:17:50 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 10:17:50 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 10:17:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 10:17:53 INFO - Downloading/unpacking functools32 (from jsonschema) 10:17:53 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 10:17:53 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 10:17:53 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 10:17:53 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 10:17:53 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 10:17:53 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 10:17:53 INFO - Downloading functools32-3.2.3-2.tar.gz 10:17:53 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 10:17:53 INFO - warning: no files found matching '*.txt' 10:17:53 INFO - no previously-included directories found matching 'build' 10:17:53 INFO - no previously-included directories found matching 'dist' 10:17:53 INFO - no previously-included directories found matching '.git*' 10:17:53 INFO - Installing collected packages: jsonschema, functools32 10:17:53 INFO - Running setup.py install for functools32 10:17:53 INFO - warning: no files found matching '*.txt' 10:17:53 INFO - no previously-included directories found matching 'build' 10:17:53 INFO - no previously-included directories found matching 'dist' 10:17:53 INFO - no previously-included directories found matching '.git*' 10:17:53 INFO - Successfully installed jsonschema functools32 10:17:53 INFO - Cleaning up... 10:17:53 INFO - Return code: 0 10:17:53 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 10:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 10:17:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 10:17:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 10:17:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 10:17:53 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 0x10b850a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b8574c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc28a5949b0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10b6f4d30>, '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 0x10b518db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ebb20>, '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.ZKCToJsGnO/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.w8g0hMwmks/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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 10:17:53 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 10:17:53 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 10:17:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZKCToJsGnO/Render', 10:17:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:17:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:17:53 INFO - 'HOME': '/Users/cltbld', 10:17:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:17:53 INFO - 'LOGNAME': 'cltbld', 10:17:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:17:53 INFO - 'MOZ_NO_REMOTE': '1', 10:17:53 INFO - 'NO_EM_RESTART': '1', 10:17:53 INFO - 'PAGER': '/bin/cat', 10:17:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:17:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:17:53 INFO - 'PWD': '/builds/slave/test', 10:17:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:17:53 INFO - 'SHELL': '/bin/bash', 10:17:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8g0hMwmks/Listeners', 10:17:53 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 10:17:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:17:53 INFO - 'USER': 'cltbld', 10:17:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:17:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:17:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:17:53 INFO - 'XPC_FLAGS': '0x0', 10:17:53 INFO - 'XPC_SERVICE_NAME': '0', 10:17:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:17:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 10:17:54 INFO - Downloading/unpacking flake8 10:17:54 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 10:17:54 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 10:17:54 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 10:17:54 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 10:17:54 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 10:17:54 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 10:17:56 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 10:17:56 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 10:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:56 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 10:17:56 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 10:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 10:17:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 10:17:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 10:17:57 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 10:17:57 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 10:17:57 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 10:17:57 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 10:17:57 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 10:17:57 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 10:17:57 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 10:17:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 10:17:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:17:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:17:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:17:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:17:57 INFO - no previously-included directories found matching 'docs/_build' 10:17:57 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 10:17:57 INFO - Running setup.py install for pep8 10:17:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 10:17:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 10:17:57 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 10:17:57 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 10:17:57 INFO - no previously-included directories found matching 'docs/_build' 10:17:57 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 10:17:57 INFO - Successfully installed flake8 mccabe pyflakes pep8 10:17:57 INFO - Cleaning up... 10:17:57 INFO - Return code: 0 10:17:57 INFO - Running post-action listener: _resource_record_post_action 10:17:57 INFO - Running post-action listener: _start_resource_monitoring 10:17:57 INFO - Starting resource monitoring. 10:17:57 INFO - ##### 10:17:57 INFO - ##### Running install step. 10:17:57 INFO - ##### 10:17:57 INFO - Running pre-action listener: _resource_record_pre_action 10:17:57 INFO - Running main action method: install 10:17:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 10:17:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 10:17:58 INFO - Reading from file tmpfile_stdout 10:17:58 INFO - Detecting whether we're running mozinstall >=1.0... 10:17:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 10:17:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 10:17:58 INFO - Reading from file tmpfile_stdout 10:17:58 INFO - Output received: 10:17:58 INFO - Usage: mozinstall [options] installer 10:17:58 INFO - Options: 10:17:58 INFO - -h, --help show this help message and exit 10:17:58 INFO - -d DEST, --destination=DEST 10:17:58 INFO - Directory to install application into. [default: 10:17:58 INFO - "/builds/slave/test"] 10:17:58 INFO - --app=APP Application being installed. [default: firefox] 10:17:58 INFO - mkdir: /builds/slave/test/build/application 10:17:58 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'] 10:17:58 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 10:18:32 INFO - Reading from file tmpfile_stdout 10:18:32 INFO - Output received: 10:18:32 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 10:18:32 INFO - Running post-action listener: _resource_record_post_action 10:18:32 INFO - ##### 10:18:32 INFO - ##### Running run-tests step. 10:18:32 INFO - ##### 10:18:32 INFO - Running pre-action listener: _resource_record_pre_action 10:18:32 INFO - Running main action method: run_tests 10:18:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:18:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:18:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:18:32 INFO - 2016-02-23 10:18:32.523 screenresolution[2441:17923] starting screenresolution argv=screenresolution get 10:18:32 INFO - 2016-02-23 10:18:32.526 screenresolution[2441:17923] Display 0: 1600x1200x32@60 10:18:32 INFO - 2016-02-23 10:18:32.531 screenresolution[2442:17925] starting screenresolution argv=screenresolution list 10:18:32 INFO - Available Modes on Display 0 10:18:32 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:18:32 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:18:32 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:18:32 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:18:32 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:18:32 INFO - Intel Iris: 10:18:32 INFO - Chipset Model: Intel Iris 10:18:32 INFO - Type: GPU 10:18:32 INFO - Bus: Built-In 10:18:32 INFO - VRAM (Dynamic, Max): 1536 MB 10:18:32 INFO - Vendor: Intel (0x8086) 10:18:32 INFO - Device ID: 0x0a2e 10:18:32 INFO - Revision ID: 0x0009 10:18:32 INFO - Displays: 10:18:32 INFO - Display: 10:18:32 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:18:32 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:18:32 INFO - Display Serial Number: 1600x1200 60 10:18:32 INFO - Main Display: Yes 10:18:32 INFO - Mirror: Off 10:18:32 INFO - Online: Yes 10:18:32 INFO - Rotation: Supported 10:18:32 INFO - Return code: 0 10:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 10:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 10:18:32 INFO - Python 2.7.3 10:18:32 INFO - Return code: 0 10:18:32 INFO - grabbing minidump binary from tooltool 10:18:32 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')]} 10:18:32 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 0x10b6f4d30>, '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 0x10b518db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10b6ebb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 10:18:32 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 10:18:32 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 10:18:32 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 10:18:32 INFO - Return code: 0 10:18:32 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 10:18:32 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 10:18:32 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 10:18:32 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 10:18:32 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 10:18:32 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 10:18:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 10:18:34 INFO - Return code: 0 10:18:34 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0057', '--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 10:18:34 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0057 --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 10:18:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ZKCToJsGnO/Render', 10:18:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 10:18:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 10:18:34 INFO - 'HOME': '/Users/cltbld', 10:18:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 10:18:34 INFO - 'LOGNAME': 'cltbld', 10:18:34 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 10:18:34 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 10:18:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 10:18:34 INFO - 'MOZ_NO_REMOTE': '1', 10:18:34 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 10:18:34 INFO - 'NO_EM_RESTART': '1', 10:18:34 INFO - 'PAGER': '/bin/cat', 10:18:34 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 10:18:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 10:18:34 INFO - 'PWD': '/builds/slave/test', 10:18:34 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 10:18:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 10:18:34 INFO - 'SHELL': '/bin/bash', 10:18:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.w8g0hMwmks/Listeners', 10:18:34 INFO - 'TMPDIR': '/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/', 10:18:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 10:18:34 INFO - 'USER': 'cltbld', 10:18:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 10:18:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 10:18:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 10:18:34 INFO - 'XPC_FLAGS': '0x0', 10:18:34 INFO - 'XPC_SERVICE_NAME': '0', 10:18:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 10:18:34 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0057', '--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 10:18:34 INFO - mozversion application_buildid: 20160223030304 10:18:34 INFO - mozversion application_changeset: 789a12291942763bc1e3a89f97e0b82dc1c9d00b 10:18:34 INFO - mozversion application_display_name: Nightly 10:18:34 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 10:18:34 INFO - mozversion application_name: Firefox 10:18:34 INFO - mozversion application_remotingname: firefox 10:18:34 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 10:18:34 INFO - mozversion application_vendor: Mozilla 10:18:34 INFO - mozversion application_version: 47.0a1 10:18:34 INFO - mozversion platform_buildid: 20160223030304 10:18:34 INFO - mozversion platform_changeset: 789a12291942763bc1e3a89f97e0b82dc1c9d00b 10:18:34 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 10:18:34 INFO - mozversion platform_version: 47.0a1 10:18:34 INFO - using testdate: 1456251514 10:18:34 INFO - actual date: 1456251514 10:18:34 INFO - starting webserver on 'localhost:51459' 10:18:34 INFO - SUITE-START | Running 2 tests 10:18:34 INFO - TEST-START | dromaeo_css 10:18:34 INFO - operating with platform_type : mac_ 10:18:34 INFO - Initialising browser for dromaeo_css test... 10:18:34 INFO - TEST-INFO | started process 2460 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpSX8T4o/profile http://localhost:51459/getInfo.html) 10:18:37 INFO - PROCESS | 2460 | __metrics Screen width/height:1600/1200 10:18:37 INFO - PROCESS | 2460 | colorDepth:24 10:18:37 INFO - PROCESS | 2460 | Browser inner width/height: 1024/689 10:18:37 INFO - PROCESS | 2460 | __metrics 10:18:37 ERROR - PROCESS | 2460 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 10:18:38 INFO - TEST-INFO | 2460: exit 0 10:18:38 INFO - Browser initialized. 10:18:38 INFO - Running cycle 1/1 for dromaeo_css test... 10:18:38 INFO - TEST-INFO | started process 2465 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmpSX8T4o/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:18:50 INFO - PROCESS | 2465 | RSS: Main: 256380928 10:18:50 INFO - PROCESS | 2465 | 10:19:39 INFO - PROCESS | 2465 | 1456251579770 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] 10:21:51 INFO - PROCESS | 2465 | Cycle 1(1): loaded http://localhost:51459/tests/dromaeo/cssquery-dojo.html (next: http://localhost:51459/tests/dromaeo/cssquery-ext.html) 10:21:52 INFO - PROCESS | 2465 | RSS: Main: 268222464 10:21:52 INFO - PROCESS | 2465 | 10:24:54 INFO - PROCESS | 2465 | Cycle 1(1): loaded http://localhost:51459/tests/dromaeo/cssquery-ext.html (next: http://localhost:51459/tests/dromaeo/cssquery-jquery.html) 10:24:54 INFO - PROCESS | 2465 | RSS: Main: 281907200 10:24:54 INFO - PROCESS | 2465 | 10:27:56 INFO - PROCESS | 2465 | Cycle 1(1): loaded http://localhost:51459/tests/dromaeo/cssquery-jquery.html (next: http://localhost:51459/tests/dromaeo/cssquery-mootools.html) 10:27:57 INFO - PROCESS | 2465 | RSS: Main: 282058752 10:27:57 INFO - PROCESS | 2465 | 10:30:59 INFO - PROCESS | 2465 | Cycle 1(1): loaded http://localhost:51459/tests/dromaeo/cssquery-mootools.html (next: http://localhost:51459/tests/dromaeo/cssquery-prototype.html) 10:30:59 INFO - PROCESS | 2465 | RSS: Main: 283848704 10:30:59 INFO - PROCESS | 2465 | 10:34:02 INFO - PROCESS | 2465 | Cycle 1(1): loaded http://localhost:51459/tests/dromaeo/cssquery-prototype.html (next: http://localhost:51459/tests/dromaeo/cssquery-yui.html) 10:34:02 INFO - PROCESS | 2465 | RSS: Main: 287772672 10:34:02 INFO - PROCESS | 2465 | 10:37:05 INFO - PROCESS | 2465 | Cycle 1(1): loaded http://localhost:51459/tests/dromaeo/cssquery-yui.html (next: http://localhost:51459/tests/dromaeo/cssquery-dojo.html) 10:37:05 INFO - PROCESS | 2465 | RSS: Main: 287690752 10:37:05 INFO - PROCESS | 2465 | 10:37:05 INFO - PROCESS | 2465 | __start_tp_report 10:37:05 INFO - PROCESS | 2465 | _x_x_mozilla_page_load 10:37:05 INFO - PROCESS | 2465 | _x_x_mozilla_page_load_details 10:37:05 INFO - PROCESS | 2465 | |i|pagename|runs| 10:37:05 INFO - PROCESS | 2465 | |0;dojo.html;2889.638795150606;3515.20907795746;3558.6085530591645;3583.050491619721;3599.226166374229;5684.914726279104;5744.080947048473;5757.971210143954;5765.827025189241;5772.39389864064;5615.578831587627;5781.364049954502;5796.971015144918;5832.125181222818;5966.194563733895;5164.122099243119;5227.895442091156;5232.764525596357;5266.394364648077;5308.575313974892;5273.709945952971;5283.577313814905;5300.204969254604;5307.469253074681;5321.547668448186;4370.688793361995;5131.794728210867;5180.326557547513;5271.86820329491;5303.920441193385;4884;5245.1869960155855;5267.183586544092;5275.841724748264;5315.7873685052555;5198.298229739013;5222.843314700565;5239.895202095937;5255.947440525584;5313.229581710631;4984.576311013569;5267.999080174793;5636.577256705723;5657.632253903483;5694.572907031989;6109.070667813036;6191.690415479208;6204.286507051656;6291.905621415683;6297.874042519124;6083.330833608299;6143.665407145256;6272.686365681743;6276.843078923018;6279.968600157015;5839.036558967765;5885.382034886361;5901.557383196277;5906.616069955439;5951.880962380771;6178.938210617926;6281.654509001957;6366.490680745529;6392.552521323556;6394.968025159845;6174.567780255339;6196.225471816023;6225.097360882647;6225.315215326311;6234.220722409699;6150.077488376779;6281.277653069956;6297.023961286008;6297.842553936097;6317.778877739257;6150.138980542728;6256.155419018465;6276.215473065867;6276.717547710364;6283.654399008098;6247.0629405589525;6263.655498947511;6270.153529273581;6285.371462853678;6292.402221789014;4879.804807807648;4923.679960802537;4985.557077032228;5002.124628190125;5018.473060328686;4398.4941731701265;4446.644268458515;4449.510553839075;4472.239719247736;4485.46174459067;5874.206982057368;5897.675627840425;5913.970430147821;5914.260717410324;5928.407159284037;6119.663418511936;6188.381161883865;6266.185395898504;6266.843328916813;6282.591631543935;5888.882222355614;5948.434898684618;5959.672218027963;5977.669454258185;5996.190514280604;5326.334208223972;5408.378036525771;5436.782528698808;5442.755076021588;5460.918086228709;5259.526642602184;6365.58623689468;6379.202599675041;6379.5215358847345;6393.041043843461;6148.493619063358;6253.7185826637;6255.31191568918;6256.843578910563;6265.185525881606;6210.7515699371515;6320.494360451245;6363.204599425072;6426.100345951477;6434.903476447951;6175.84560385994;6206.844828879314;6241.4084408477365;6241.78153764616;6260.561760676891;6275.058741188675;6276;6276.184096067482;6295;6311.526635502448;6059.969700151471;6143.539234557336;6173;6186.412290832363;6186.443220110212;5945.940540594539;6162.568620196544;6167.229096362955;6179.876402471836;6197.96901015492;5913.29040515141;5956.8808623828145;6018.4884284834525;6028.728707208098;6088.969555152196;6116.969415152896;6144.692765361803;6155.753769849156;6172.2901866284155;6183.474404675653;4898.730569818694;6065.181200538047;6113.786017489367;6121.8469538260115;6137.342917412363 10:37:05 INFO - PROCESS | 2465 | |1;ext.html;455.73339596336143;498.96215870988345;536.444779653059;564.8898464799364;603.6016229288671;30968.38063238737;31209.68790312096;38221.42667859981;38233.61766382339;38248.61751382485;41524.58475415245;41892;42160.94597635061;42217.57782422175;42247.78876105623;9570.665026724066;9727.610895564205;9771.36486128403;9793.11861932426;9858.211343092571;8453.788655283637;9644.710658680217;9778.217742580611;9782.853257201148;9799.657012004582;9735;9753.170980466633;9813.65652202173;9815.018498150199;9831.557579908922;9704.126628603424;9733.415995040321;9775.511224438786;9781.951090244575;9803.607855685765;9545.761355966088;9641.180499657537;9654.469004204766;9698.854517182248;9727.56225969833;38728.61271387278;38820.02949926246;39003;39059.21881562381;39109.0445477725;2627.4351014531967;3196.137042998401;3516.7889926604485;3746.718996075278;3809.7142714296538;28935.56596651052;29048.41903161946;29605.851970740223;30311.24221894448;30312.393752124834;2763.350612606036;2800.9439811203865;2805.4950108980374;2844.0330287702072;2863.541833306661;375018.12490937643;378292;378558;381871.090644545;381991.0900445508;45384;45793.5420645796;46559;64407;64928.675356622916;44920.550794492294;45130;45402.545974540495;45613;45649.54350456519;13591.728165436636;15427.61430964235;15449.691006179813;15744.527664170093;15771.29029193689;10620.52207650642;11155.442227888572;11786.057115430916;12617.242965422103;12709.491620335082;14821.851781482048;14915.403383864741;15000.399984000518;15040.623984400478;15066.623334416508;6327.96836015817;6462.1276127723095;6467.838304042342;6490.415862572391;6494.214091124884;951.1392190068;977.3647129365827;999.9600415567874;1026.4508487959056;1043.6295115233982;25736.74263257381;29457.55813662797;29637.962671306832;30103.698963010527;30159.944401946264;1062.8352605346183;1067.5783065689166;1149.545929357899;1174.3423682737694;1183.3136780667191;15198.088114713153;15454.150021748912;15555.922220388826;15579;15710.293036813142;553357;636444;643980.7800960966;646077;662981;61606;61811;62622;62806.68596656987;62912;1471.9632009199856;1474.388128926505;1480.2302802542617;1487.5091219897408;1591.9652226052926;30987.69012309848;31107.22231944129;31272.530912035883;31707.20731981719;32016.5197522042;52170.47829521808;52659;52868.20697689461;53311.733441332544;53783.73108134434;482672;483546;487148;487701;488463;33235.66764332326;33351.83324083364;33599.496007560396;33916.660833391354;33918.321633567684;44918;45156.548434515236;45592;46395;46428.767856160506;37167.62832371642;37845.86462406132;37856.242875142896;37880.810595946845;38064.80967595255;36760;37282.81358593189;37592.496300148785;37879;38993.80503097466;36015.63984360228;37697.62302376941;39238.80380598079;39340.409893852186;39439;30103;32314.676853231165;32369.51445728363;32538.023859284258;32796.34407311888;20186.39440816778;24678.629820553066;25006.62490062687;25383.36541586475;25490.490190196462 10:37:05 INFO - PROCESS | 2465 | |2;jquery.html;312.27240529566114;341.73217363581114;369.7245552063711;372.29078605256984;376.43346763121497;15670.059796412195;19491.707624385628;19558.804411955876;19928.9003554982;20597.38207853763;20063;20100.296489622866;20339.796602033974;20378.082986265617;20405.591888162264;5648.124540696199;5783.595148339597;5799.971000144993;5904.409559044083;5928.170056192136;5785.595008349417;5856.033754430535;5884.588078834483;5892.852678683024;5908.911366329487;4121.319982202933;5595.272614560102;5863.618864773797;5953.493953013999;6260.718267677966;6459.580127291734;6471.223453185601;6473.74105035798;6511.186101737283;6514.534229798305;5544.3346798384455;5558.944410555923;5643.068893632546;5644.153376993443;5673.092305231144;16611.920225185324;24297.757022429727;24460.87769561141;24896.751032489625;24984.875075624688;2192.177933275022;2205.9190996411644;2385.101285123057;2555.527227462907;2573.3566608347915;11574.421278936019;13961.3717382717;14114.364853581614;14836.777448338284;15180;1546.2268865567216;1714.4170981866225;1767.54043948573;1771.3977247735831;1789.2753434858903;91772;95042.52478737562;97290.51354743252;97320;98202;8718.782030449289;10350.171986241083;10734.516946737416;10788.46057697112;10909.672709818718;12924.806127907901;12929.159604625669;12978.35108244584;13012.544560940321;13026.674333141747;8394;8508.446950948168;8531.701390451304;8590.269827064645;8606.655733770704;8673.91326086731;8693.739187824376;8724.258438032712;8725.996510401259;8728.908886389201;4916.213405855046;5472.835814925558;6288;6288.119663247149;6309.305976342599;1647.3904655277383;1844.5480857189807;1852.8425083868021;1856.3502774028982;1886.9528261793564;396.5162501747863;412.3567235113233;431.9611234988866;936.0218571592702;1023.8464230365356;11545;11856.940715296369;11857.932786049298;20412.0814563345;20986.685199722015;902.8871391076116;936.3960245641659;945.8675785390051;997.3567049253191;1014.7158795537262;10346.53440595175;10892.727681807859;10952;10956.890431095588;11131.276467029616;520324;531238;532118;645274;646416;116805.4159729196;130660.38679226363;132146;135349.6465035337;136704;1028.861103750999;1038.963636272742;1050.3382868792764;1052.4053909541237;1070.357785328812;18003;18686.25254989785;18836;18878.96165710899;19367.612647746686;32076.19809504688;33008.83495582507;52740;55224;55777.44222557722;72343;81360.59319703364;81648.59175704083;82513;82747.5862620683;7777.533347998912;8039.638216280165;8045.678950780479;8097.473664211808;8171.387145963958;9494.85757713621;13168.564010385537;13198.010149238653;13207.537736179187;13376.598702038955;8424.873626895478;10927.672169834917;11139.888601113886;11291.830622540832;11503.137264705014;11201.495932682887;11434.484413429032;11627.534898604299;11724.531018759495;11784.76430471403;5571.1086226203615;9147.405418647766;9246.029166937375;11678.941605291919;11735.882641173479;7822.569758663328;8109.837803243784;8121.5533145677555;8134.267915887362;8274.834503310021;8560.785980350542;11218.326900386002;11304.717382065186;11465.541378344773;11915.40422978865 10:37:05 INFO - PROCESS | 2465 | |3;mootools.html;1542.3599206329375;1555.6266496040946;1808.2550338922936;1927.2387406974253;1928.19979708421;6933.341332573404;7029.121359830021;8097.068837083737;8352.832943341129;8674.91325086749;8680.652773889053;8755.430896991707;8781.121887811232;8785.472871627691;8849.734507964771;2446.131623273739;2453.0800949643885;2468.2841975826987;2471.159805666073;2490.750924907513;2428.9757102428925;2486.365976675945;2494.962575561368;2495.25142457263;2509.4228327484598;2452.264320703791;2478.7769100780924;2481.7642323979194;2506.1980166346775;2513.861737604431;2105.5157313817754;2458.791002764767;2478.3432390416465;2482.714487833904;2492.72580016199;2462.150558057467;2479.47930934504;2484.5776218042975;2487;2496.3135137837057;8961.148690874357;8962.058983806672;9000.504972226525;9021.233195178418;9038.593263303168;5304.549113325372;5467;5484.451554844523;5491.066518691792;5545.1682247663175;3392.914267434422;3599.7940689868924;3663.303972245265;3693.113652723354;3740.3828368319196;986.9950650246775;1070.4059247117846;1074.1889873145803;1082.2965072702727;1086.0714089453481;11944.104192185621;12071.577494787729;12092.6372208833;12092.637220883387;12101.636950891487;4890.413150421972;4913.803447862046;4944.3572335596145;4974.403071631355;4989.002199560103;10076.798464030824;10085;10142.847857282146;10164.288499804943;10170.491475426199;5436.266104075899;5443.945560544344;5473.972630136904;5481.862953426196;5483.122700367922;4385.3641222022625;4811.109944660249;4884.145274576935;4969.378827646544;4979.975100124476;3941.4087886817206;3948.309045916953;3981.1042515433796;4004.599540045972;4008.6392224699334;1085.7122862441458;1317.3808310094241;1321.6960099177052;1330.3082397153619;1330.534312990465;1313.2317594207304;1335.3857225676104;1337.0106121470042;1350.4260689207047;1388.2364699415282;8123.7156699515235;8144.185581441809;8173.305269052078;8176.059753128467;8184.754457366289;513.7919142747194;518.4167811212386;524.8005757812083;526.557691539109;531.8936212757465;6200.3179650238435;6201.875962480725;6235.282942461675;6240.843978900564;6260.405261500241;8048.436609437284;10685.626003089854;10880.78238435227;10904.563817447372;11083.168762342857;10575.682729518127;10590.311629744043;10632.41521716313;10670.839937400946;10724.78550428987;8203.220694034057;8292.212239837207;8312.625931833081;8357;8452.28155606768;7772.572508512086;7775.416843736629;7784.260495252942;7841.294283514511;7851.371890248653;9449.858252126362;9581.329306948726;9587;9587.904120958701;9683;9856.85214721794;9906.851397228904;10059.094681478702;10102.595896164072;10177;5537.529310008534;6699.698513566998;7293.343599076109;7426.554406735613;7439.888401673871;8053.718119865776;8097.190280971856;8124.309433697966;8162.7143049992965;8163.836723265383;7116.217216106328;7216.422686185198;7288.599127048064;7386.667599957907;7434.033575635132;5849.94150058494;7170.820729481596;7185.245549217257;7316.414686825147;7385.113786345673;7489.850202995801;7604.923950760422;7614.543127412373;7631;7669.041369828771;6875.690593923386;6878.449724022166;6971.79084627462;6977.988191712275;6983.825404364931;6927.861442771217;7013.123359580052;7068.3285087916565;7072.71709131629;7095.113110861143 10:37:05 INFO - PROCESS | 2465 | |4;prototype.html;318.66062643284897;331.1406899096843;333.20530534674793;333.73301358912863;340.06143045195256;6568.376004279586;6638.535302528825;6714.153607757857;6728.293529179439;6932.168139823229;6645.900311495319;6676.833079173023;6683.866322673543;6700.832479188023;6710.328967103287;4144.792760361985;4962.131626965284;4983.07813054586;4985;4991.7504124793795;4939.3578834751615;5024.422191447976;5029.019341228462;5042.520960508746;5056.443791182967;4957.504249575031;4981.427135879384;4983.501649835024;4987.301777751118;4993.226049962262;4090.9590904091024;4607.470140933802;4818.4217893852965;4968.2795994580765;4997.775100120485;4043.4541336919433;4082.040720430696;4096.303628383182;4102.897427564305;4113.4035564843225;6257.217847769029;6351.872962540723;6366.968165159191;6371.649559274238;6377.553571250014;5641.1384243199645;5695.14572814077;5709.343425506078;5713.971430142864;5760.164776107483;7117.89323160153;7149.463790215703;7150.10623672041;7162.176349719797;7196.496245262833;4403.251447253974;4553.863384098482;4571.200039993021;4580.221362368406;4592.2422800238255;7503.699852005913;7525;7544.132424771112;7595.392368610498;7639.6944122235045;4415.227335216388;4583.289590113538;4666.883327916829;4669.509701481364;4670.579647831712;4728.503507131771;4747.169245382044;4750.883542367541;4753.310769938409;4770.189067858472;5655.915161272585;5668.829935101871;5671.035923892948;5685.431456854364;5691.0609749391715;6888.965555172192;7191.928080719126;7209.279072092749;7213.783586492414;7218.169910460259;1626.5770899566198;1627.9023258604523;1643.5233782203027;1647.1270226779825;1650.257384177125;868.2923417414787;969.0842154164388;1036.8652075230173;1066.5040756048475;1098.6429410441638;6671.266160722316;6678.899816502756;6692.83267918306;6710.932890671031;6751.156105486814;6521.967390163114;6668.86629273015;6772.661366931732;7334.706611735471;7339.926600734031;5980.222571065734;6659.234188068434;6715.918065399742;6751.223609284995;6787.592744435251;3595.3168897909313;3915.1778126593736;3943.4479172915817;3953.92092158161;3972.920541589152;6647.800565983028;7401.33387995083;7734.7679569613;7963.960180199062;8015.278624923785;7766.029246344207;7772.106207786064;7799;7802.219778022152;7819.296263336327;7925.801854953557;7929.841403171904;7963.4027447941635;7965.243301886311;7967.083785364642;7180.928190718026;7488.138864030706;7493.241791462569;7512.474126811071;7548.924510754822;7418.443616728659;7428.220036896048;7440.144383395762;7453.068366454193;7478.4765066447;7880.802979925547;7906.644201011083;7912.36701063902;7917.564533950688;7974.122846486998;4641.280601506772;4714.834980775657;4715.952840471551;4721.693089949143;4727.361806156125;6707.429868461236;7199.3520583147765;7469.850602987801;7494.400447964041;7524.962375188089;7266.491345605757;7275.490715649854;7297.525660832029;7298.343149116605;7309.342159205697;7248.420126389981;7289.781306560812;7291.489595728248;7340.192578816433;7346.375558077623;7116.074910261633;7124.216336203117;7151.53515021522;7155.749548765768;7160.713571457083;6983.196932352845;7237.746678866214;7250.60121693312;7271.709131634675;7282.890756638549;7026.648667566704;7101;7103.502754807114;7125.216226215216;7144.4641651877355 10:37:05 INFO - PROCESS | 2465 | |5;yui.html;715.3633266392908;729.2707292707296;741.9554826710398;753.0962844586497;756.0662581711586;12256.203346782453;14661.926690366547;14865.256737163152;14969.775453368207;15007.099574025566;13746.93126534366;13808.033437659367;15380.61548461289;15716.292766825492;15803;701.961392123433;881.1012766977678;882.2765332427396;883.2889523933231;898.2409863665225;840.6721378662327;895.7805337692274;895.8118795053014;896.9013408525057;899.1278459893892;936.5644975086583;937.2782957123011;941.1341565759518;941.4680705401427;942.820864035831;904.9954750226273;907.9319051071196;924.2513564013171;929.1126973740062;929.7164364868712;669.3875104279579;671.3689132215702;681.7443458702986;697.2817997462622;698.2179958446521;15113.54659360221;15188.544343669708;15305.1582162981;15321.387144514207;15325.003874748105;12536.874631253662;12586.622401327882;12668;12966.740665186644;13185.077044606882;8992.955035224848;9360.765980850465;10271.332363396356;10607.257491975564;10994.120470362352;3056.2970516781043;3365.3774051800497;3443.6728510791436;3471.392506311385;3480.6519348065244;64884.78248913805;70826.64586677085;76890.61554692246;76970.23029769743;79046;8305.667773289122;9508.524573771283;9678.70963871085;9711.174550163316;10025.899741002642;18512;20607.381778546667;20665;20871;20947.581048378946;7449.739259125905;7530.774076777706;7698.2686644768655;7801.2198780121535;7873.881891771628;3471.351935050851;4143.647789937829;4170.91658166835;4179.97910010448;4208.9789551052045;3257.03917344384;3378.9493157602656;3389.271306669078;3598.946015809765;3657.396529572644;664.4817042706696;666.5367569539123;668.2081733146238;676.8172593399754;677.701811203069;516.7752027867889;527.385595780911;550.771429856605;554.5674373988215;578.5400606517744;7545.698172073166;8512.361572882059;9074.86387704185;9195.77010574741;9474.194693451134;544.6897690258322;597.9133025711335;624.1823211592828;635.6059243269202;636.7643971730397;3864.9806750966063;4013.819378127991;4092.570280120604;4192.832286708558;4193.97903010483;93732.53133734288;95594.5220273908;96024;96410.51794740981;96534.51732741432;76211.61894190604;78097;80017;80901.97745056421;81300.59349703214;72075.6396218026;72526.27473725301;72998.27001730021;73850.2614973854;74065;8780.736577902673;8807.194525122462;8824.382293239412;8825.073367296342;9301.953490232505;49770.25344619761;50091.248631271286;50169;50235.99528009346;51070.74464627653;66669.66665166643;68846;69245;69958;69995.65002174956;10884.183686223407;10998.780024399628;11327.660170194908;11730.76538469243;11918.702032449259;10388.480575971322;11784.646460606196;11990.100742444178;12000.39998000079;12557.623271301876;11333.433328333715;11433.085353171893;11657.18399712012;11976.46105925253;12050.276983381025;11573.59492417795;11774.764504710029;11908.940455298014;11910.754065354504;12031.27812331263;11444.427778611203;11569.074474041889;11604.201039792335;11639.709007274547;12343.629691109281;9562.353688053054;9659.178969787647;9700.660476883275;9940.055694708992;10283.845742313722;7856.332211762065;9172.54137293146;9230.400023998418;10098.798024039625;10103.848442273518 10:37:05 INFO - PROCESS | 2465 | __end_tp_report 10:37:05 INFO - PROCESS | 2465 | __start_cc_report 10:37:05 INFO - PROCESS | 2465 | _x_x_mozilla_cycle_collect,343 10:37:05 INFO - PROCESS | 2465 | __end_cc_report 10:37:05 INFO - PROCESS | 2465 | __startTimestamp1456252625422__endTimestamp 10:37:05 INFO - PROCESS | 2465 | 10:37:05 INFO - PROCESS | 2465 | ------- Summary: start ------- 10:37:05 INFO - PROCESS | 2465 | Number of tests: 6 10:37:05 INFO - PROCESS | 2465 | 10:37:05 INFO - PROCESS | 2465 | [#0] dojo.html Cycles:165 Average:5774.97 Median:6059.97 stddev:655.72 (10.8%) stddev-sans-first:617.43 10:37:05 INFO - PROCESS | 2465 | Values: 2889.6 3515.2 3558.6 3583.1 3599.2 5684.9 5744.1 5758.0 5765.8 5772.4 5615.6 5781.4 5797.0 5832.1 5966.2 5164.1 5227.9 5232.8 5266.4 5308.6 5273.7 5283.6 5300.2 5307.5 5321.5 4370.7 5131.8 5180.3 5271.9 5303.9 4884.0 5245.2 5267.2 5275.8 5315.8 5198.3 5222.8 5239.9 5255.9 5313.2 4984.6 5268.0 5636.6 5657.6 5694.6 6109.1 6191.7 6204.3 6291.9 6297.9 6083.3 6143.7 6272.7 6276.8 6280.0 5839.0 5885.4 5901.6 5906.6 5951.9 6178.9 6281.7 6366.5 6392.6 6395.0 6174.6 6196.2 6225.1 6225.3 6234.2 6150.1 6281.3 6297.0 6297.8 6317.8 6150.1 6256.2 6276.2 6276.7 6283.7 6247.1 6263.7 6270.2 6285.4 6292.4 4879.8 4923.7 4985.6 5002.1 5018.5 4398.5 4446.6 4449.5 4472.2 4485.5 5874.2 5897.7 5914.0 5914.3 5928.4 6119.7 6188.4 6266.2 6266.8 6282.6 5888.9 5948.4 5959.7 5977.7 5996.2 5326.3 5408.4 5436.8 5442.8 5460.9 5259.5 6365.6 6379.2 6379.5 6393.0 6148.5 6253.7 6255.3 6256.8 6265.2 6210.8 6320.5 6363.2 6426.1 6434.9 6175.8 6206.8 6241.4 6241.8 6260.6 6275.1 6276.0 6276.2 6295.0 6311.5 6060.0 6143.5 6173.0 6186.4 6186.4 5945.9 6162.6 6167.2 6179.9 6198.0 5913.3 5956.9 6018.5 6028.7 6089.0 6117.0 6144.7 6155.8 6172.3 6183.5 4898.7 6065.2 6113.8 6121.8 6137.3 10:37:05 INFO - PROCESS | 2465 | 10:37:05 INFO - PROCESS | 2465 | [#1] ext.html Cycles:180 Average:63501.93 Median:38227.52 stddev:135855.64 (355.4%) stddev-sans-first:136154.29 10:37:05 INFO - PROCESS | 2465 | Values: 455.7 499.0 536.4 564.9 603.6 30968.4 31209.7 38221.4 38233.6 38248.6 41524.6 41892.0 42160.9 42217.6 42247.8 9570.7 9727.6 9771.4 9793.1 9858.2 8453.8 9644.7 9778.2 9782.9 9799.7 9735.0 9753.2 9813.7 9815.0 9831.6 9704.1 9733.4 9775.5 9782.0 9803.6 9545.8 9641.2 9654.5 9698.9 9727.6 38728.6 38820.0 39003.0 39059.2 39109.0 2627.4 3196.1 3516.8 3746.7 3809.7 28935.6 29048.4 29605.9 30311.2 30312.4 2763.4 2800.9 2805.5 2844.0 2863.5 375018.1 378292.0 378558.0 381871.1 381991.1 45384.0 45793.5 46559.0 64407.0 64928.7 44920.6 45130.0 45402.5 45613.0 45649.5 13591.7 15427.6 15449.7 15744.5 15771.3 10620.5 11155.4 11786.1 12617.2 12709.5 14821.9 14915.4 15000.4 15040.6 15066.6 6328.0 6462.1 6467.8 6490.4 6494.2 951.1 977.4 1000.0 1026.5 1043.6 25736.7 29457.6 29638.0 30103.7 30159.9 1062.8 1067.6 1149.5 1174.3 1183.3 15198.1 15454.2 15555.9 15579.0 15710.3 553357.0 636444.0 643980.8 646077.0 662981.0 61606.0 61811.0 62622.0 62806.7 62912.0 1472.0 1474.4 1480.2 1487.5 1592.0 30987.7 31107.2 31272.5 31707.2 32016.5 52170.5 52659.0 52868.2 53311.7 53783.7 482672.0 483546.0 487148.0 487701.0 488463.0 33235.7 33351.8 33599.5 33916.7 33918.3 44918.0 45156.5 45592.0 46395.0 46428.8 37167.6 37845.9 37856.2 37880.8 38064.8 36760.0 37282.8 37592.5 37879.0 38993.8 36015.6 37697.6 39238.8 39340.4 39439.0 30103.0 32314.7 32369.5 32538.0 32796.3 20186.4 24678.6 25006.6 25383.4 25490.5 10:37:05 INFO - PROCESS | 2465 | 10:37:05 INFO - PROCESS | 2465 | [#2] jquery.html Cycles:180 Average:33451.75 Median:16194.24 stddev:96345.05 (594.9%) stddev-sans-first:96583.19 10:37:05 INFO - PROCESS | 2465 | Values: 312.3 341.7 369.7 372.3 376.4 15670.1 19491.7 19558.8 19928.9 20597.4 20063.0 20100.3 20339.8 20378.1 20405.6 5648.1 5783.6 5800.0 5904.4 5928.2 5785.6 5856.0 5884.6 5892.9 5908.9 4121.3 5595.3 5863.6 5953.5 6260.7 6459.6 6471.2 6473.7 6511.2 6514.5 5544.3 5558.9 5643.1 5644.2 5673.1 16611.9 24297.8 24460.9 24896.8 24984.9 2192.2 2205.9 2385.1 2555.5 2573.4 11574.4 13961.4 14114.4 14836.8 15180.0 1546.2 1714.4 1767.5 1771.4 1789.3 91772.0 95042.5 97290.5 97320.0 98202.0 8718.8 10350.2 10734.5 10788.5 10909.7 12924.8 12929.2 12978.4 13012.5 13026.7 8394.0 8508.4 8531.7 8590.3 8606.7 8673.9 8693.7 8724.3 8726.0 8728.9 4916.2 5472.8 6288.0 6288.1 6309.3 1647.4 1844.5 1852.8 1856.4 1887.0 396.5 412.4 432.0 936.0 1023.8 11545.0 11856.9 11857.9 20412.1 20986.7 902.9 936.4 945.9 997.4 1014.7 10346.5 10892.7 10952.0 10956.9 11131.3 520324.0 531238.0 532118.0 645274.0 646416.0 116805.4 130660.4 132146.0 135349.6 136704.0 1028.9 1039.0 1050.3 1052.4 1070.4 18003.0 18686.3 18836.0 18879.0 19367.6 32076.2 33008.8 52740.0 55224.0 55777.4 72343.0 81360.6 81648.6 82513.0 82747.6 7777.5 8039.6 8045.7 8097.5 8171.4 9494.9 13168.6 13198.0 13207.5 13376.6 8424.9 10927.7 11139.9 11291.8 11503.1 11201.5 11434.5 11627.5 11724.5 11784.8 5571.1 9147.4 9246.0 11678.9 11735.9 7822.6 8109.8 8121.6 8134.3 8274.8 8560.8 11218.3 11304.7 11465.5 11915.4 10:37:05 INFO - PROCESS | 2465 | 10:37:05 INFO - PROCESS | 2465 | [#3] mootools.html Cycles:180 Average:6006.54 Median:2918.22 stddev:3185.81 (109.2%) stddev-sans-first:3177.07 10:37:05 INFO - PROCESS | 2465 | Values: 1542.4 1555.6 1808.3 1927.2 1928.2 6933.3 7029.1 8097.1 8352.8 8674.9 8680.7 8755.4 8781.1 8785.5 8849.7 2446.1 2453.1 2468.3 2471.2 2490.8 2429.0 2486.4 2495.0 2495.3 2509.4 2452.3 2478.8 2481.8 2506.2 2513.9 2105.5 2458.8 2478.3 2482.7 2492.7 2462.2 2479.5 2484.6 2487.0 2496.3 8961.1 8962.1 9000.5 9021.2 9038.6 5304.5 5467.0 5484.5 5491.1 5545.2 3392.9 3599.8 3663.3 3693.1 3740.4 987.0 1070.4 1074.2 1082.3 1086.1 11944.1 12071.6 12092.6 12092.6 12101.6 4890.4 4913.8 4944.4 4974.4 4989.0 10076.8 10085.0 10142.8 10164.3 10170.5 5436.3 5443.9 5474.0 5481.9 5483.1 4385.4 4811.1 4884.1 4969.4 4980.0 3941.4 3948.3 3981.1 4004.6 4008.6 1085.7 1317.4 1321.7 1330.3 1330.5 1313.2 1335.4 1337.0 1350.4 1388.2 8123.7 8144.2 8173.3 8176.1 8184.8 513.8 518.4 524.8 526.6 531.9 6200.3 6201.9 6235.3 6240.8 6260.4 8048.4 10685.6 10880.8 10904.6 11083.2 10575.7 10590.3 10632.4 10670.8 10724.8 8203.2 8292.2 8312.6 8357.0 8452.3 7772.6 7775.4 7784.3 7841.3 7851.4 9449.9 9581.3 9587.0 9587.9 9683.0 9856.9 9906.9 10059.1 10102.6 10177.0 5537.5 6699.7 7293.3 7426.6 7439.9 8053.7 8097.2 8124.3 8162.7 8163.8 7116.2 7216.4 7288.6 7386.7 7434.0 5849.9 7170.8 7185.2 7316.4 7385.1 7489.9 7604.9 7614.5 7631.0 7669.0 6875.7 6878.4 6971.8 6978.0 6983.8 6927.9 7013.1 7068.3 7072.7 7095.1 10:37:05 INFO - PROCESS | 2465 | 10:37:05 INFO - PROCESS | 2465 | [#4] prototype.html Cycles:180 Average:5879.41 Median:6696.83 stddev:1915.52 (28.6%) stddev-sans-first:1874.87 10:37:05 INFO - PROCESS | 2465 | Values: 318.7 331.1 333.2 333.7 340.1 6568.4 6638.5 6714.2 6728.3 6932.2 6645.9 6676.8 6683.9 6700.8 6710.3 4144.8 4962.1 4983.1 4985.0 4991.8 4939.4 5024.4 5029.0 5042.5 5056.4 4957.5 4981.4 4983.5 4987.3 4993.2 4091.0 4607.5 4818.4 4968.3 4997.8 4043.5 4082.0 4096.3 4102.9 4113.4 6257.2 6351.9 6367.0 6371.6 6377.6 5641.1 5695.1 5709.3 5714.0 5760.2 7117.9 7149.5 7150.1 7162.2 7196.5 4403.3 4553.9 4571.2 4580.2 4592.2 7503.7 7525.0 7544.1 7595.4 7639.7 4415.2 4583.3 4666.9 4669.5 4670.6 4728.5 4747.2 4750.9 4753.3 4770.2 5655.9 5668.8 5671.0 5685.4 5691.1 6889.0 7191.9 7209.3 7213.8 7218.2 1626.6 1627.9 1643.5 1647.1 1650.3 868.3 969.1 1036.9 1066.5 1098.6 6671.3 6678.9 6692.8 6710.9 6751.2 6522.0 6668.9 6772.7 7334.7 7339.9 5980.2 6659.2 6715.9 6751.2 6787.6 3595.3 3915.2 3943.4 3953.9 3972.9 6647.8 7401.3 7734.8 7964.0 8015.3 7766.0 7772.1 7799.0 7802.2 7819.3 7925.8 7929.8 7963.4 7965.2 7967.1 7180.9 7488.1 7493.2 7512.5 7548.9 7418.4 7428.2 7440.1 7453.1 7478.5 7880.8 7906.6 7912.4 7917.6 7974.1 4641.3 4714.8 4716.0 4721.7 4727.4 6707.4 7199.4 7469.9 7494.4 7525.0 7266.5 7275.5 7297.5 7298.3 7309.3 7248.4 7289.8 7291.5 7340.2 7346.4 7116.1 7124.2 7151.5 7155.7 7160.7 6983.2 7237.7 7250.6 7271.7 7282.9 7026.6 7101.0 7103.5 7125.2 7144.5 10:37:05 INFO - PROCESS | 2465 | 10:37:05 INFO - PROCESS | 2465 | [#5] yui.html Cycles:180 Average:18408.08 Median:636.19 stddev:25842.35 (4062.1%) stddev-sans-first:25880.70 10:37:05 INFO - PROCESS | 2465 | Values: 715.4 729.3 742.0 753.1 756.1 12256.2 14661.9 14865.3 14969.8 15007.1 13746.9 13808.0 15380.6 15716.3 15803.0 702.0 881.1 882.3 883.3 898.2 840.7 895.8 895.8 896.9 899.1 936.6 937.3 941.1 941.5 942.8 905.0 907.9 924.3 929.1 929.7 669.4 671.4 681.7 697.3 698.2 15113.5 15188.5 15305.2 15321.4 15325.0 12536.9 12586.6 12668.0 12966.7 13185.1 8993.0 9360.8 10271.3 10607.3 10994.1 3056.3 3365.4 3443.7 3471.4 3480.7 64884.8 70826.6 76890.6 76970.2 79046.0 8305.7 9508.5 9678.7 9711.2 10025.9 18512.0 20607.4 20665.0 20871.0 20947.6 7449.7 7530.8 7698.3 7801.2 7873.9 3471.4 4143.6 4170.9 4180.0 4209.0 3257.0 3378.9 3389.3 3598.9 3657.4 664.5 666.5 668.2 676.8 677.7 516.8 527.4 550.8 554.6 578.5 7545.7 8512.4 9074.9 9195.8 9474.2 544.7 597.9 624.2 635.6 636.8 3865.0 4013.8 4092.6 4192.8 4194.0 93732.5 95594.5 96024.0 96410.5 96534.5 76211.6 78097.0 80017.0 80902.0 81300.6 72075.6 72526.3 72998.3 73850.3 74065.0 8780.7 8807.2 8824.4 8825.1 9302.0 49770.3 50091.2 50169.0 50236.0 51070.7 66669.7 68846.0 69245.0 69958.0 69995.7 10884.2 10998.8 11327.7 11730.8 11918.7 10388.5 11784.6 11990.1 12000.4 12557.6 11333.4 11433.1 11657.2 11976.5 12050.3 11573.6 11774.8 11908.9 11910.8 12031.3 11444.4 11569.1 11604.2 11639.7 12343.6 9562.4 9659.2 9700.7 9940.1 10283.8 7856.3 9172.5 9230.4 10098.8 10103.8 10:37:05 INFO - PROCESS | 2465 | -------- Summary: end -------- 10:37:05 INFO - PROCESS | 2465 | 10:37:05 INFO - TEST-INFO | 2465: exit 0 10:37:05 INFO - TEST-OK | dromaeo_css | took 1111645ms 10:37:05 INFO - TEST-START | kraken 10:37:05 INFO - operating with platform_type : mac_ 10:37:05 INFO - Initialising browser for kraken test... 10:37:05 INFO - TEST-INFO | started process 2471 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmp8DwXUi/profile http://localhost:51459/getInfo.html) 10:37:08 INFO - PROCESS | 2471 | __metrics Screen width/height:1600/1200 10:37:08 INFO - PROCESS | 2471 | colorDepth:24 10:37:08 INFO - PROCESS | 2471 | Browser inner width/height: 1024/689 10:37:08 INFO - PROCESS | 2471 | __metrics 10:37:08 ERROR - PROCESS | 2471 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2844: TypeError: this.tabs is undefined 10:37:09 INFO - TEST-INFO | 2471: exit 0 10:37:09 INFO - Browser initialized. 10:37:09 INFO - Running cycle 1/1 for kraken test... 10:37:09 INFO - TEST-INFO | started process 2475 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/T/tmp8DwXUi/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:37:21 INFO - PROCESS | 2475 | RSS: Main: 255664128 10:37:21 INFO - PROCESS | 2475 | 10:37:24 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:51459/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:51459/tests/kraken/driver.html?testName=audio-beat-detection) 10:37:24 INFO - PROCESS | 2475 | RSS: Main: 268677120 10:37:24 INFO - PROCESS | 2475 | 10:37:27 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:51459/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:51459/tests/kraken/driver.html?testName=audio-dft) 10:37:28 INFO - PROCESS | 2475 | RSS: Main: 278872064 10:37:28 INFO - PROCESS | 2475 | 10:37:31 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:51459/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:51459/tests/kraken/driver.html?testName=audio-fft) 10:37:32 INFO - PROCESS | 2475 | RSS: Main: 281276416 10:37:32 INFO - PROCESS | 2475 | 10:37:33 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:51459/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:51459/tests/kraken/driver.html?testName=audio-oscillator) 10:37:34 INFO - PROCESS | 2475 | RSS: Main: 281751552 10:37:34 INFO - PROCESS | 2475 | 10:37:36 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:51459/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:51459/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:37:37 INFO - PROCESS | 2475 | RSS: Main: 284295168 10:37:37 INFO - PROCESS | 2475 | 10:37:40 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:51459/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:51459/tests/kraken/driver.html?testName=imaging-darkroom) 10:37:40 INFO - PROCESS | 2475 | RSS: Main: 283250688 10:37:40 INFO - PROCESS | 2475 | 10:37:43 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:51459/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:51459/tests/kraken/driver.html?testName=imaging-desaturate) 10:37:44 INFO - PROCESS | 2475 | RSS: Main: 283017216 10:37:44 INFO - PROCESS | 2475 | 10:37:47 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:51459/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:51459/tests/kraken/driver.html?testName=json-parse-financial) 10:37:47 INFO - PROCESS | 2475 | RSS: Main: 283406336 10:37:47 INFO - PROCESS | 2475 | 10:37:49 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:51459/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:51459/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:37:49 INFO - PROCESS | 2475 | RSS: Main: 284450816 10:37:49 INFO - PROCESS | 2475 | 10:37:51 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:51459/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:51459/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:37:52 INFO - PROCESS | 2475 | RSS: Main: 284340224 10:37:52 INFO - PROCESS | 2475 | 10:37:54 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:51459/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:51459/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:37:54 INFO - PROCESS | 2475 | RSS: Main: 284106752 10:37:54 INFO - PROCESS | 2475 | 10:37:57 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:51459/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:51459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:37:58 INFO - PROCESS | 2475 | RSS: Main: 284209152 10:37:58 INFO - PROCESS | 2475 | 10:38:00 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:51459/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:51459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:38:01 INFO - PROCESS | 2475 | RSS: Main: 283107328 10:38:01 INFO - PROCESS | 2475 | 10:38:02 INFO - PROCESS | 2475 | Cycle 1(1): loaded http://localhost:51459/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:51459/tests/kraken/driver.html?testName=ai-astar) 10:38:03 INFO - PROCESS | 2475 | RSS: Main: 285057024 10:38:03 INFO - PROCESS | 2475 | 10:38:03 INFO - PROCESS | 2475 | __start_tp_report 10:38:03 INFO - PROCESS | 2475 | _x_x_mozilla_page_load 10:38:03 INFO - PROCESS | 2475 | _x_x_mozilla_page_load_details 10:38:03 INFO - PROCESS | 2475 | |i|pagename|runs| 10:38:03 INFO - PROCESS | 2475 | |0;ai-astar;116;117;116;114;113;125;114;114;116;112 10:38:03 INFO - PROCESS | 2475 | |1;audio-beat-detection;175;127;146;154;132;135;164;122;144;128 10:38:03 INFO - PROCESS | 2475 | |2;audio-dft;200;220;195;211;205;240;269;243;201;188 10:38:03 INFO - PROCESS | 2475 | |3;audio-fft;57;65;70;70;105;57;65;86;85;142 10:38:03 INFO - PROCESS | 2475 | |4;audio-oscillator;105;66;121;109;118;119;122;78;83;115 10:38:03 INFO - PROCESS | 2475 | |5;imaging-gaussian-blur;120;127;86;95;86;83;128;92;88;91 10:38:03 INFO - PROCESS | 2475 | |6;imaging-darkroom;153;96;96;94;95;96;96;96;96;95 10:38:03 INFO - PROCESS | 2475 | |7;imaging-desaturate;91;98;91;93;93;91;119;142;121;90 10:38:03 INFO - PROCESS | 2475 | |8;json-parse-financial;58;56;56;57;56;56;57;61;55;56 10:38:03 INFO - PROCESS | 2475 | |9;json-stringify-tinderbox;64;66;98;98;73;72;66;82;97;59 10:38:03 INFO - PROCESS | 2475 | |10;stanford-crypto-aes;89;84;87;83;87;90;86;87;88;86 10:38:03 INFO - PROCESS | 2475 | |11;stanford-crypto-ccm;127;136;135;133;113;126;124;125;133;164 10:38:03 INFO - PROCESS | 2475 | |12;stanford-crypto-pbkdf2;141;141;138;138;141;120;164;175;160;136 10:38:03 INFO - PROCESS | 2475 | |13;stanford-crypto-sha256-iterative;67;69;68;67;72;71;65;69;66;69 10:38:03 INFO - PROCESS | 2475 | __end_tp_report 10:38:03 INFO - PROCESS | 2475 | __start_cc_report 10:38:03 INFO - PROCESS | 2475 | _x_x_mozilla_cycle_collect,874 10:38:03 INFO - PROCESS | 2475 | __end_cc_report 10:38:03 INFO - PROCESS | 2475 | __startTimestamp1456252683218__endTimestamp 10:38:03 INFO - PROCESS | 2475 | 10:38:03 INFO - PROCESS | 2475 | ------- Summary: start ------- 10:38:03 INFO - PROCESS | 2475 | Number of tests: 14 10:38:03 INFO - PROCESS | 2475 | 10:38:03 INFO - PROCESS | 2475 | [#0] ai-astar Cycles:10 Average:115.70 Median:116.00 stddev:3.62 (3.1%) stddev-sans-first:3.84 10:38:03 INFO - PROCESS | 2475 | Values: 116.0 117.0 116.0 114.0 113.0 125.0 114.0 114.0 116.0 112.0 10:38:03 INFO - PROCESS | 2475 | 10:38:03 INFO - PROCESS | 2475 | [#1] audio-beat-detection Cycles:10 Average:142.70 Median:145.00 stddev:17.33 (11.9%) stddev-sans-first:13.89 10:38:03 INFO - PROCESS | 2475 | Values: 175.0 127.0 146.0 154.0 132.0 135.0 164.0 122.0 144.0 128.0 10:38:03 INFO - PROCESS | 2475 | 10:38:03 INFO - PROCESS | 2475 | [#2] audio-dft Cycles:10 Average:217.20 Median:215.50 stddev:25.75 (11.9%) stddev-sans-first:26.55 10:38:03 INFO - PROCESS | 2475 | Values: 200.0 220.0 195.0 211.0 205.0 240.0 269.0 243.0 201.0 188.0 10:38:03 INFO - PROCESS | 2475 | 10:38:03 INFO - PROCESS | 2475 | [#3] audio-fft Cycles:10 Average:80.20 Median:67.50 stddev:26.33 (39.0%) stddev-sans-first:26.55 10:38:03 INFO - PROCESS | 2475 | Values: 57.0 65.0 70.0 70.0 105.0 57.0 65.0 86.0 85.0 142.0 10:38:03 INFO - PROCESS | 2475 | 10:38:03 INFO - PROCESS | 2475 | [#4] audio-oscillator Cycles:10 Average:103.60 Median:121.50 stddev:20.39 (16.8%) stddev-sans-first:21.62 10:38:03 INFO - PROCESS | 2475 | Values: 105.0 66.0 121.0 109.0 118.0 119.0 122.0 78.0 83.0 115.0 10:38:03 INFO - PROCESS | 2475 | 10:38:03 INFO - PROCESS | 2475 | [#5] imaging-gaussian-blur Cycles:10 Average:99.60 Median:87.00 stddev:17.97 (20.7%) stddev-sans-first:17.48 10:38:03 INFO - PROCESS | 2475 | Values: 120.0 127.0 86.0 95.0 86.0 83.0 128.0 92.0 88.0 91.0 10:38:03 INFO - PROCESS | 2475 | 10:38:03 INFO - PROCESS | 2475 | [#6] imaging-darkroom Cycles:10 Average:101.30 Median:96.00 stddev:18.18 (18.9%) stddev-sans-first:0.73 10:38:03 INFO - PROCESS | 2475 | Values: 153.0 96.0 96.0 94.0 95.0 96.0 96.0 96.0 96.0 95.0 10:38:03 INFO - PROCESS | 2475 | 10:38:03 INFO - PROCESS | 2475 | [#7] imaging-desaturate Cycles:10 Average:102.90 Median:91.00 stddev:18.03 (19.8%) stddev-sans-first:18.61 10:38:03 INFO - PROCESS | 2475 | Values: 91.0 98.0 91.0 93.0 93.0 91.0 119.0 142.0 121.0 90.0 10:38:03 INFO - PROCESS | 2475 | 10:38:03 INFO - PROCESS | 2475 | [#8] json-parse-financial Cycles:10 Average:56.80 Median:56.50 stddev:1.69 (3.0%) stddev-sans-first:1.73 10:38:03 INFO - PROCESS | 2475 | Values: 58.0 56.0 56.0 57.0 56.0 56.0 57.0 61.0 55.0 56.0 10:38:03 INFO - PROCESS | 2475 | 10:38:03 INFO - PROCESS | 2475 | [#9] json-stringify-tinderbox Cycles:10 Average:77.50 Median:77.50 stddev:15.20 (19.6%) stddev-sans-first:15.32 10:38:03 INFO - PROCESS | 2475 | Values: 64.0 66.0 98.0 98.0 73.0 72.0 66.0 82.0 97.0 59.0 10:38:03 INFO - PROCESS | 2475 | 10:38:03 INFO - PROCESS | 2475 | [#10] stanford-crypto-aes Cycles:10 Average:86.70 Median:87.00 stddev:2.11 (2.4%) stddev-sans-first:2.07 10:38:03 INFO - PROCESS | 2475 | Values: 89.0 84.0 87.0 83.0 87.0 90.0 86.0 87.0 88.0 86.0 10:38:03 INFO - PROCESS | 2475 | 10:38:03 INFO - PROCESS | 2475 | [#11] stanford-crypto-ccm Cycles:10 Average:131.60 Median:133.00 stddev:13.27 (10.0%) stddev-sans-first:13.97 10:38:03 INFO - PROCESS | 2475 | Values: 127.0 136.0 135.0 133.0 113.0 126.0 124.0 125.0 133.0 164.0 10:38:03 INFO - PROCESS | 2475 | 10:38:03 INFO - PROCESS | 2475 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:145.40 Median:141.00 stddev:16.11 (11.4%) stddev-sans-first:17.01 10:38:03 INFO - PROCESS | 2475 | Values: 141.0 141.0 138.0 138.0 141.0 120.0 164.0 175.0 160.0 136.0 10:38:03 INFO - PROCESS | 2475 | 10:38:03 INFO - PROCESS | 2475 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:68.30 Median:69.00 stddev:2.16 (3.1%) stddev-sans-first:2.24 10:38:03 INFO - PROCESS | 2475 | Values: 67.0 69.0 68.0 67.0 72.0 71.0 65.0 69.0 66.0 69.0 10:38:03 INFO - PROCESS | 2475 | -------- Summary: end -------- 10:38:03 INFO - PROCESS | 2475 | 10:38:03 INFO - TEST-INFO | 2475: exit 0 10:38:03 INFO - TEST-OK | kraken | took 57984ms 10:38:03 INFO - SUITE-END | took 1169s 10:38:04 INFO - Completed test suite (00:19:30) 10:38:04 INFO - Working with test: dromaeo_css 10:38:04 INFO - Generating results file: dromaeo_css 10:38:04 INFO - Working with test: kraken 10:38:04 INFO - Generating results file: kraken 10:38:04 INFO - javascript benchmark 10:38:04 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:38:04 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,1,61]] 10:38:04 INFO - process_Request line: dromaeo_css 7514.97 graph.html#tests=[[72,1,61]] 10:38:04 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:38:04 INFO - process_Request line: kraken 1529.50 graph.html#tests=[[232,1,61]] 10:38:04 INFO - RETURN: dromaeo_css: 7514.97 10:38:04 INFO - RETURN: kraken: 1529.50 10:38:04 INFO - javascript benchmark 10:38:04 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [2889.638795150606, 3515.20907795746, 3558.6085530591645, 3583.050491619721, 3599.226166374229, 5684.914726279104, 5744.080947048473, 5757.971210143954, 5765.827025189241, 5772.39389864064, 5615.578831587627, 5781.364049954502, 5796.971015144918, 5832.125181222818, 5966.194563733895, 5164.122099243119, 5227.895442091156, 5232.764525596357, 5266.394364648077, 5308.575313974892, 5273.709945952971, 5283.577313814905, 5300.204969254604, 5307.469253074681, 5321.547668448186, 4370.688793361995, 5131.794728210867, 5180.326557547513, 5271.86820329491, 5303.920441193385, 4884.0, 5245.1869960155855, 5267.183586544092, 5275.841724748264, 5315.7873685052555, 5198.298229739013, 5222.843314700565, 5239.895202095937, 5255.947440525584, 5313.229581710631, 4984.576311013569, 5267.999080174793, 5636.577256705723, 5657.632253903483, 5694.572907031989, 6109.070667813036, 6191.690415479208, 6204.286507051656, 6291.905621415683, 6297.874042519124, 6083.330833608299, 6143.665407145256, 6272.686365681743, 6276.843078923018, 6279.968600157015, 5839.036558967765, 5885.382034886361, 5901.557383196277, 5906.616069955439, 5951.880962380771, 6178.938210617926, 6281.654509001957, 6366.490680745529, 6392.552521323556, 6394.968025159845, 6174.567780255339, 6196.225471816023, 6225.097360882647, 6225.315215326311, 6234.220722409699, 6150.077488376779, 6281.277653069956, 6297.023961286008, 6297.842553936097, 6317.778877739257, 6150.138980542728, 6256.155419018465, 6276.215473065867, 6276.717547710364, 6283.654399008098, 6247.0629405589525, 6263.655498947511, 6270.153529273581, 6285.371462853678, 6292.402221789014, 4879.804807807648, 4923.679960802537, 4985.557077032228, 5002.124628190125, 5018.473060328686, 4398.4941731701265, 4446.644268458515, 4449.510553839075, 4472.239719247736, 4485.46174459067, 5874.206982057368, 5897.675627840425, 5913.970430147821, 5914.260717410324, 5928.407159284037, 6119.663418511936, 6188.381161883865, 6266.185395898504, 6266.843328916813, 6282.591631543935, 5888.882222355614, 5948.434898684618, 5959.672218027963, 5977.669454258185, 5996.190514280604, 5326.334208223972, 5408.378036525771, 5436.782528698808, 5442.755076021588, 5460.918086228709, 5259.526642602184, 6365.58623689468, 6379.202599675041, 6379.5215358847345, 6393.041043843461, 6148.493619063358, 6253.7185826637, 6255.31191568918, 6256.843578910563, 6265.185525881606, 6210.7515699371515, 6320.494360451245, 6363.204599425072, 6426.100345951477, 6434.903476447951, 6175.84560385994, 6206.844828879314, 6241.4084408477365, 6241.78153764616, 6260.561760676891, 6275.058741188675, 6276.0, 6276.184096067482, 6295.0, 6311.526635502448, 6059.969700151471, 6143.539234557336, 6173.0, 6186.412290832363, 6186.443220110212, 5945.940540594539, 6162.568620196544, 6167.229096362955, 6179.876402471836, 6197.96901015492, 5913.29040515141, 5956.8808623828145, 6018.4884284834525, 6028.728707208098, 6088.969555152196, 6116.969415152896, 6144.692765361803, 6155.753769849156, 6172.2901866284155, 6183.474404675653, 4898.730569818694, 6065.181200538047, 6113.786017489367, 6121.8469538260115, 6137.342917412363], "unit": "score", "name": "dojo.html", "value": 5733.644805379359}, {"lowerIsBetter": false, "replicates": [455.73339596336143, 498.96215870988345, 536.444779653059, 564.8898464799364, 603.6016229288671, 30968.38063238737, 31209.68790312096, 38221.42667859981, 38233.61766382339, 38248.61751382485, 41524.58475415245, 41892.0, 42160.94597635061, 42217.57782422175, 42247.78876105623, 9570.665026724066, 9727.610895564205, 9771.36486128403, 9793.11861932426, 9858.211343092571, 8453.788655283637, 9644.710658680217, 9778.217742580611, 9782.853257201148, 9799.657012004582, 9735.0, 9753.170980466633, 9813.65652202173, 9815.018498150199, 9831.557579908922, 9704.126628603424, 9733.415995040321, 9775.511224438786, 9781.951090244575, 9803.607855685765, 9545.761355966088, 9641.180499657537, 9654.469004204766, 9698.854517182248, 9727.56225969833, 38728.61271387278, 38820.02949926246, 39003.0, 39059.21881562381, 39109.0445477725, 2627.4351014531967, 3196.137042998401, 3516.7889926604485, 3746.718996075278, 3809.7142714296538, 28935.56596651052, 29048.41903161946, 29605.851970740223, 30311.24221894448, 30312.393752124834, 2763.350612606036, 2800.9439811203865, 2805.4950108980374, 2844.0330287702072, 2863.541833306661, 375018.12490937643, 378292.0, 378558.0, 381871.090644545, 381991.0900445508, 45384.0, 45793.5420645796, 46559.0, 64407.0, 64928.675356622916, 44920.550794492294, 45130.0, 45402.545974540495, 45613.0, 45649.54350456519, 13591.728165436636, 15427.61430964235, 15449.691006179813, 15744.527664170093, 15771.29029193689, 10620.52207650642, 11155.442227888572, 11786.057115430916, 12617.242965422103, 12709.491620335082, 14821.851781482048, 14915.403383864741, 15000.399984000518, 15040.623984400478, 15066.623334416508, 6327.96836015817, 6462.1276127723095, 6467.838304042342, 6490.415862572391, 6494.214091124884, 951.1392190068, 977.3647129365827, 999.9600415567874, 1026.4508487959056, 1043.6295115233982, 25736.74263257381, 29457.55813662797, 29637.962671306832, 30103.698963010527, 30159.944401946264, 1062.8352605346183, 1067.5783065689166, 1149.545929357899, 1174.3423682737694, 1183.3136780667191, 15198.088114713153, 15454.150021748912, 15555.922220388826, 15579.0, 15710.293036813142, 553357.0, 636444.0, 643980.7800960966, 646077.0, 662981.0, 61606.0, 61811.0, 62622.0, 62806.68596656987, 62912.0, 1471.9632009199856, 1474.388128926505, 1480.2302802542617, 1487.5091219897408, 1591.9652226052926, 30987.69012309848, 31107.22231944129, 31272.530912035883, 31707.20731981719, 32016.5197522042, 52170.47829521808, 52659.0, 52868.20697689461, 53311.733441332544, 53783.73108134434, 482672.0, 483546.0, 487148.0, 487701.0, 488463.0, 33235.66764332326, 33351.83324083364, 33599.496007560396, 33916.660833391354, 33918.321633567684, 44918.0, 45156.548434515236, 45592.0, 46395.0, 46428.767856160506, 37167.62832371642, 37845.86462406132, 37856.242875142896, 37880.810595946845, 38064.80967595255, 36760.0, 37282.81358593189, 37592.496300148785, 37879.0, 38993.80503097466, 36015.63984360228, 37697.62302376941, 39238.80380598079, 39340.409893852186, 39439.0, 30103.0, 32314.676853231165, 32369.51445728363, 32538.023859284258, 32796.34407311888, 20186.39440816778, 24678.629820553066, 25006.62490062687, 25383.36541586475, 25490.490190196462], "unit": "score", "name": "ext.html", "value": 19282.936983894433}, {"lowerIsBetter": false, "replicates": [312.27240529566114, 341.73217363581114, 369.7245552063711, 372.29078605256984, 376.43346763121497, 15670.059796412195, 19491.707624385628, 19558.804411955876, 19928.9003554982, 20597.38207853763, 20063.0, 20100.296489622866, 20339.796602033974, 20378.082986265617, 20405.591888162264, 5648.124540696199, 5783.595148339597, 5799.971000144993, 5904.409559044083, 5928.170056192136, 5785.595008349417, 5856.033754430535, 5884.588078834483, 5892.852678683024, 5908.911366329487, 4121.319982202933, 5595.272614560102, 5863.618864773797, 5953.493953013999, 6260.718267677966, 6459.580127291734, 6471.223453185601, 6473.74105035798, 6511.186101737283, 6514.534229798305, 5544.3346798384455, 5558.944410555923, 5643.068893632546, 5644.153376993443, 5673.092305231144, 16611.920225185324, 24297.757022429727, 24460.87769561141, 24896.751032489625, 24984.875075624688, 2192.177933275022, 2205.9190996411644, 2385.101285123057, 2555.527227462907, 2573.3566608347915, 11574.421278936019, 13961.3717382717, 14114.364853581614, 14836.777448338284, 15180.0, 1546.2268865567216, 1714.4170981866225, 1767.54043948573, 1771.3977247735831, 1789.2753434858903, 91772.0, 95042.52478737562, 97290.51354743252, 97320.0, 98202.0, 8718.782030449289, 10350.171986241083, 10734.516946737416, 10788.46057697112, 10909.672709818718, 12924.806127907901, 12929.159604625669, 12978.35108244584, 13012.544560940321, 13026.674333141747, 8394.0, 8508.446950948168, 8531.701390451304, 8590.269827064645, 8606.655733770704, 8673.91326086731, 8693.739187824376, 8724.258438032712, 8725.996510401259, 8728.908886389201, 4916.213405855046, 5472.835814925558, 6288.0, 6288.119663247149, 6309.305976342599, 1647.3904655277383, 1844.5480857189807, 1852.8425083868021, 1856.3502774028982, 1886.9528261793564, 396.5162501747863, 412.3567235113233, 431.9611234988866, 936.0218571592702, 1023.8464230365356, 11545.0, 11856.940715296369, 11857.932786049298, 20412.0814563345, 20986.685199722015, 902.8871391076116, 936.3960245641659, 945.8675785390051, 997.3567049253191, 1014.7158795537262, 10346.53440595175, 10892.727681807859, 10952.0, 10956.890431095588, 11131.276467029616, 520324.0, 531238.0, 532118.0, 645274.0, 646416.0, 116805.4159729196, 130660.38679226363, 132146.0, 135349.6465035337, 136704.0, 1028.861103750999, 1038.963636272742, 1050.3382868792764, 1052.4053909541237, 1070.357785328812, 18003.0, 18686.25254989785, 18836.0, 18878.96165710899, 19367.612647746686, 32076.19809504688, 33008.83495582507, 52740.0, 55224.0, 55777.44222557722, 72343.0, 81360.59319703364, 81648.59175704083, 82513.0, 82747.5862620683, 7777.533347998912, 8039.638216280165, 8045.678950780479, 8097.473664211808, 8171.387145963958, 9494.85757713621, 13168.564010385537, 13198.010149238653, 13207.537736179187, 13376.598702038955, 8424.873626895478, 10927.672169834917, 11139.888601113886, 11291.830622540832, 11503.137264705014, 11201.495932682887, 11434.484413429032, 11627.534898604299, 11724.531018759495, 11784.76430471403, 5571.1086226203615, 9147.405418647766, 9246.029166937375, 11678.941605291919, 11735.882641173479, 7822.569758663328, 8109.837803243784, 8121.5533145677555, 8134.267915887362, 8274.834503310021, 8560.785980350542, 11218.326900386002, 11304.717382065186, 11465.541378344773, 11915.40422978865], "unit": "score", "name": "jquery.html", "value": 9295.389180110587}, {"lowerIsBetter": false, "replicates": [1542.3599206329375, 1555.6266496040946, 1808.2550338922936, 1927.2387406974253, 1928.19979708421, 6933.341332573404, 7029.121359830021, 8097.068837083737, 8352.832943341129, 8674.91325086749, 8680.652773889053, 8755.430896991707, 8781.121887811232, 8785.472871627691, 8849.734507964771, 2446.131623273739, 2453.0800949643885, 2468.2841975826987, 2471.159805666073, 2490.750924907513, 2428.9757102428925, 2486.365976675945, 2494.962575561368, 2495.25142457263, 2509.4228327484598, 2452.264320703791, 2478.7769100780924, 2481.7642323979194, 2506.1980166346775, 2513.861737604431, 2105.5157313817754, 2458.791002764767, 2478.3432390416465, 2482.714487833904, 2492.72580016199, 2462.150558057467, 2479.47930934504, 2484.5776218042975, 2487.0, 2496.3135137837057, 8961.148690874357, 8962.058983806672, 9000.504972226525, 9021.233195178418, 9038.593263303168, 5304.549113325372, 5467.0, 5484.451554844523, 5491.066518691792, 5545.1682247663175, 3392.914267434422, 3599.7940689868924, 3663.303972245265, 3693.113652723354, 3740.3828368319196, 986.9950650246775, 1070.4059247117846, 1074.1889873145803, 1082.2965072702727, 1086.0714089453481, 11944.104192185621, 12071.577494787729, 12092.6372208833, 12092.637220883387, 12101.636950891487, 4890.413150421972, 4913.803447862046, 4944.3572335596145, 4974.403071631355, 4989.002199560103, 10076.798464030824, 10085.0, 10142.847857282146, 10164.288499804943, 10170.491475426199, 5436.266104075899, 5443.945560544344, 5473.972630136904, 5481.862953426196, 5483.122700367922, 4385.3641222022625, 4811.109944660249, 4884.145274576935, 4969.378827646544, 4979.975100124476, 3941.4087886817206, 3948.309045916953, 3981.1042515433796, 4004.599540045972, 4008.6392224699334, 1085.7122862441458, 1317.3808310094241, 1321.6960099177052, 1330.3082397153619, 1330.534312990465, 1313.2317594207304, 1335.3857225676104, 1337.0106121470042, 1350.4260689207047, 1388.2364699415282, 8123.7156699515235, 8144.185581441809, 8173.305269052078, 8176.059753128467, 8184.754457366289, 513.7919142747194, 518.4167811212386, 524.8005757812083, 526.557691539109, 531.8936212757465, 6200.3179650238435, 6201.875962480725, 6235.282942461675, 6240.843978900564, 6260.405261500241, 8048.436609437284, 10685.626003089854, 10880.78238435227, 10904.563817447372, 11083.168762342857, 10575.682729518127, 10590.311629744043, 10632.41521716313, 10670.839937400946, 10724.78550428987, 8203.220694034057, 8292.212239837207, 8312.625931833081, 8357.0, 8452.28155606768, 7772.572508512086, 7775.416843736629, 7784.260495252942, 7841.294283514511, 7851.371890248653, 9449.858252126362, 9581.329306948726, 9587.0, 9587.904120958701, 9683.0, 9856.85214721794, 9906.851397228904, 10059.094681478702, 10102.595896164072, 10177.0, 5537.529310008534, 6699.698513566998, 7293.343599076109, 7426.554406735613, 7439.888401673871, 8053.718119865776, 8097.190280971856, 8124.309433697966, 8162.7143049992965, 8163.836723265383, 7116.217216106328, 7216.422686185198, 7288.599127048064, 7386.667599957907, 7434.033575635132, 5849.94150058494, 7170.820729481596, 7185.245549217257, 7316.414686825147, 7385.113786345673, 7489.850202995801, 7604.923950760422, 7614.543127412373, 7631.0, 7669.041369828771, 6875.690593923386, 6878.449724022166, 6971.79084627462, 6977.988191712275, 6983.825404364931, 6927.861442771217, 7013.123359580052, 7068.3285087916565, 7072.71709131629, 7095.113110861143], "unit": "score", "name": "mootools.html", "value": 4833.045965275164}, {"lowerIsBetter": false, "replicates": [318.66062643284897, 331.1406899096843, 333.20530534674793, 333.73301358912863, 340.06143045195256, 6568.376004279586, 6638.535302528825, 6714.153607757857, 6728.293529179439, 6932.168139823229, 6645.900311495319, 6676.833079173023, 6683.866322673543, 6700.832479188023, 6710.328967103287, 4144.792760361985, 4962.131626965284, 4983.07813054586, 4985.0, 4991.7504124793795, 4939.3578834751615, 5024.422191447976, 5029.019341228462, 5042.520960508746, 5056.443791182967, 4957.504249575031, 4981.427135879384, 4983.501649835024, 4987.301777751118, 4993.226049962262, 4090.9590904091024, 4607.470140933802, 4818.4217893852965, 4968.2795994580765, 4997.775100120485, 4043.4541336919433, 4082.040720430696, 4096.303628383182, 4102.897427564305, 4113.4035564843225, 6257.217847769029, 6351.872962540723, 6366.968165159191, 6371.649559274238, 6377.553571250014, 5641.1384243199645, 5695.14572814077, 5709.343425506078, 5713.971430142864, 5760.164776107483, 7117.89323160153, 7149.463790215703, 7150.10623672041, 7162.176349719797, 7196.496245262833, 4403.251447253974, 4553.863384098482, 4571.200039993021, 4580.221362368406, 4592.2422800238255, 7503.699852005913, 7525.0, 7544.132424771112, 7595.392368610498, 7639.6944122235045, 4415.227335216388, 4583.289590113538, 4666.883327916829, 4669.509701481364, 4670.579647831712, 4728.503507131771, 4747.169245382044, 4750.883542367541, 4753.310769938409, 4770.189067858472, 5655.915161272585, 5668.829935101871, 5671.035923892948, 5685.431456854364, 5691.0609749391715, 6888.965555172192, 7191.928080719126, 7209.279072092749, 7213.783586492414, 7218.169910460259, 1626.5770899566198, 1627.9023258604523, 1643.5233782203027, 1647.1270226779825, 1650.257384177125, 868.2923417414787, 969.0842154164388, 1036.8652075230173, 1066.5040756048475, 1098.6429410441638, 6671.266160722316, 6678.899816502756, 6692.83267918306, 6710.932890671031, 6751.156105486814, 6521.967390163114, 6668.86629273015, 6772.661366931732, 7334.706611735471, 7339.926600734031, 5980.222571065734, 6659.234188068434, 6715.918065399742, 6751.223609284995, 6787.592744435251, 3595.3168897909313, 3915.1778126593736, 3943.4479172915817, 3953.92092158161, 3972.920541589152, 6647.800565983028, 7401.33387995083, 7734.7679569613, 7963.960180199062, 8015.278624923785, 7766.029246344207, 7772.106207786064, 7799.0, 7802.219778022152, 7819.296263336327, 7925.801854953557, 7929.841403171904, 7963.4027447941635, 7965.243301886311, 7967.083785364642, 7180.928190718026, 7488.138864030706, 7493.241791462569, 7512.474126811071, 7548.924510754822, 7418.443616728659, 7428.220036896048, 7440.144383395762, 7453.068366454193, 7478.4765066447, 7880.802979925547, 7906.644201011083, 7912.36701063902, 7917.564533950688, 7974.122846486998, 4641.280601506772, 4714.834980775657, 4715.952840471551, 4721.693089949143, 4727.361806156125, 6707.429868461236, 7199.3520583147765, 7469.850602987801, 7494.400447964041, 7524.962375188089, 7266.491345605757, 7275.490715649854, 7297.525660832029, 7298.343149116605, 7309.342159205697, 7248.420126389981, 7289.781306560812, 7291.489595728248, 7340.192578816433, 7346.375558077623, 7116.074910261633, 7124.216336203117, 7151.53515021522, 7155.749548765768, 7160.713571457083, 6983.196932352845, 7237.746678866214, 7250.60121693312, 7271.709131634675, 7282.890756638549, 7026.648667566704, 7101.0, 7103.502754807114, 7125.216226215216, 7144.4641651877355], "unit": "score", "name": "prototype.html", "value": 5228.272266285116}, {"lowerIsBetter": false, "replicates": [715.3633266392908, 729.2707292707296, 741.9554826710398, 753.0962844586497, 756.0662581711586, 12256.203346782453, 14661.926690366547, 14865.256737163152, 14969.775453368207, 15007.099574025566, 13746.93126534366, 13808.033437659367, 15380.61548461289, 15716.292766825492, 15803.0, 701.961392123433, 881.1012766977678, 882.2765332427396, 883.2889523933231, 898.2409863665225, 840.6721378662327, 895.7805337692274, 895.8118795053014, 896.9013408525057, 899.1278459893892, 936.5644975086583, 937.2782957123011, 941.1341565759518, 941.4680705401427, 942.820864035831, 904.9954750226273, 907.9319051071196, 924.2513564013171, 929.1126973740062, 929.7164364868712, 669.3875104279579, 671.3689132215702, 681.7443458702986, 697.2817997462622, 698.2179958446521, 15113.54659360221, 15188.544343669708, 15305.1582162981, 15321.387144514207, 15325.003874748105, 12536.874631253662, 12586.622401327882, 12668.0, 12966.740665186644, 13185.077044606882, 8992.955035224848, 9360.765980850465, 10271.332363396356, 10607.257491975564, 10994.120470362352, 3056.2970516781043, 3365.3774051800497, 3443.6728510791436, 3471.392506311385, 3480.6519348065244, 64884.78248913805, 70826.64586677085, 76890.61554692246, 76970.23029769743, 79046.0, 8305.667773289122, 9508.524573771283, 9678.70963871085, 9711.174550163316, 10025.899741002642, 18512.0, 20607.381778546667, 20665.0, 20871.0, 20947.581048378946, 7449.739259125905, 7530.774076777706, 7698.2686644768655, 7801.2198780121535, 7873.881891771628, 3471.351935050851, 4143.647789937829, 4170.91658166835, 4179.97910010448, 4208.9789551052045, 3257.03917344384, 3378.9493157602656, 3389.271306669078, 3598.946015809765, 3657.396529572644, 664.4817042706696, 666.5367569539123, 668.2081733146238, 676.8172593399754, 677.701811203069, 516.7752027867889, 527.385595780911, 550.771429856605, 554.5674373988215, 578.5400606517744, 7545.698172073166, 8512.361572882059, 9074.86387704185, 9195.77010574741, 9474.194693451134, 544.6897690258322, 597.9133025711335, 624.1823211592828, 635.6059243269202, 636.7643971730397, 3864.9806750966063, 4013.819378127991, 4092.570280120604, 4192.832286708558, 4193.97903010483, 93732.53133734288, 95594.5220273908, 96024.0, 96410.51794740981, 96534.51732741432, 76211.61894190604, 78097.0, 80017.0, 80901.97745056421, 81300.59349703214, 72075.6396218026, 72526.27473725301, 72998.27001730021, 73850.2614973854, 74065.0, 8780.736577902673, 8807.194525122462, 8824.382293239412, 8825.073367296342, 9301.953490232505, 49770.25344619761, 50091.248631271286, 50169.0, 50235.99528009346, 51070.74464627653, 66669.66665166643, 68846.0, 69245.0, 69958.0, 69995.65002174956, 10884.183686223407, 10998.780024399628, 11327.660170194908, 11730.76538469243, 11918.702032449259, 10388.480575971322, 11784.646460606196, 11990.100742444178, 12000.39998000079, 12557.623271301876, 11333.433328333715, 11433.085353171893, 11657.18399712012, 11976.46105925253, 12050.276983381025, 11573.59492417795, 11774.764504710029, 11908.940455298014, 11910.754065354504, 12031.27812331263, 11444.427778611203, 11569.074474041889, 11604.201039792335, 11639.709007274547, 12343.629691109281, 9562.353688053054, 9659.178969787647, 9700.660476883275, 9940.055694708992, 10283.845742313722, 7856.332211762065, 9172.54137293146, 9230.400023998418, 10098.798024039625, 10103.848442273518], "unit": "score", "name": "yui.html", "value": 6935.517873245355}], "name": "dromaeo_css", "value": 7514.96952606478}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [116.0, 117.0, 116.0, 114.0, 113.0, 125.0, 114.0, 114.0, 116.0, 112.0], "unit": "score", "name": "ai-astar", "value": 115.7}, {"lowerIsBetter": true, "replicates": [175.0, 127.0, 146.0, 154.0, 132.0, 135.0, 164.0, 122.0, 144.0, 128.0], "unit": "score", "name": "audio-beat-detection", "value": 142.7}, {"lowerIsBetter": true, "replicates": [200.0, 220.0, 195.0, 211.0, 205.0, 240.0, 269.0, 243.0, 201.0, 188.0], "unit": "score", "name": "audio-dft", "value": 217.2}, {"lowerIsBetter": true, "replicates": [57.0, 65.0, 70.0, 70.0, 105.0, 57.0, 65.0, 86.0, 85.0, 142.0], "unit": "score", "name": "audio-fft", "value": 80.2}, {"lowerIsBetter": true, "replicates": [105.0, 66.0, 121.0, 109.0, 118.0, 119.0, 122.0, 78.0, 83.0, 115.0], "unit": "score", "name": "audio-oscillator", "value": 103.6}, {"lowerIsBetter": true, "replicates": [120.0, 127.0, 86.0, 95.0, 86.0, 83.0, 128.0, 92.0, 88.0, 91.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 99.6}, {"lowerIsBetter": true, "replicates": [153.0, 96.0, 96.0, 94.0, 95.0, 96.0, 96.0, 96.0, 96.0, 95.0], "unit": "score", "name": "imaging-darkroom", "value": 101.3}, {"lowerIsBetter": true, "replicates": [91.0, 98.0, 91.0, 93.0, 93.0, 91.0, 119.0, 142.0, 121.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 102.9}, {"lowerIsBetter": true, "replicates": [58.0, 56.0, 56.0, 57.0, 56.0, 56.0, 57.0, 61.0, 55.0, 56.0], "unit": "score", "name": "json-parse-financial", "value": 56.8}, {"lowerIsBetter": true, "replicates": [64.0, 66.0, 98.0, 98.0, 73.0, 72.0, 66.0, 82.0, 97.0, 59.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 77.5}, {"lowerIsBetter": true, "replicates": [89.0, 84.0, 87.0, 83.0, 87.0, 90.0, 86.0, 87.0, 88.0, 86.0], "unit": "score", "name": "stanford-crypto-aes", "value": 86.7}, {"lowerIsBetter": true, "replicates": [127.0, 136.0, 135.0, 133.0, 113.0, 126.0, 124.0, 125.0, 133.0, 164.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 131.6}, {"lowerIsBetter": true, "replicates": [141.0, 141.0, 138.0, 138.0, 141.0, 120.0, 164.0, 175.0, 160.0, 136.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 145.4}, {"lowerIsBetter": true, "replicates": [67.0, 69.0, 68.0, 67.0, 72.0, 71.0, 65.0, 69.0, 66.0, 69.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 68.3}], "name": "kraken", "value": 1529.5}]} 10:38:04 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,61]]", "result": "1529.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,61]]", "result": "7514.97"}}} 10:38:04 INFO - Return code: 0 10:38:04 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:38:04 ERROR - # TBPL SUCCESS # 10:38:04 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:38:04 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:38:04 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:38:04 INFO - 2016-02-23 10:38:04.986 screenresolution[2480:20666] starting screenresolution argv=screenresolution get 10:38:04 INFO - 2016-02-23 10:38:04.988 screenresolution[2480:20666] Display 0: 1600x1200x32@60 10:38:04 INFO - 2016-02-23 10:38:04.994 screenresolution[2481:20669] starting screenresolution argv=screenresolution list 10:38:04 INFO - Available Modes on Display 0 10:38:04 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:38:04 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:38:04 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:38:04 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:38:05 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:38:05 INFO - Intel Iris: 10:38:05 INFO - Chipset Model: Intel Iris 10:38:05 INFO - Type: GPU 10:38:05 INFO - Bus: Built-In 10:38:05 INFO - VRAM (Dynamic, Max): 1536 MB 10:38:05 INFO - Vendor: Intel (0x8086) 10:38:05 INFO - Device ID: 0x0a2e 10:38:05 INFO - Revision ID: 0x0009 10:38:05 INFO - Displays: 10:38:05 INFO - Display: 10:38:05 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:38:05 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:38:05 INFO - Display Serial Number: 1600x1200 60 10:38:05 INFO - Main Display: Yes 10:38:05 INFO - Mirror: Off 10:38:05 INFO - Online: Yes 10:38:05 INFO - Rotation: Supported 10:38:05 INFO - Return code: 0 10:38:05 INFO - Running post-action listener: _resource_record_post_action 10:38:05 INFO - Running post-run listener: _resource_record_post_run 10:38:06 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 1147392; Write bytes: 711621120; Read time: 15; Write time: 2036 10:38:06 INFO - install - Wall time: 35s; CPU: 54.0%; Read bytes: 394973696; Write bytes: 389506560; Read time: 30224; Write time: 688 10:38:06 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 1147392; Write bytes: 304210944; Read time: 15; Write time: 1305 10:38:06 INFO - Running post-run listener: _upload_blobber_files 10:38:06 INFO - Blob upload gear active. 10:38:06 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:38:06 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 10:38:06 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'] 10:38:06 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 10:38:06 INFO - (blobuploader) - INFO - Open directory for files ... 10:38:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:38:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:07 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:38:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:07 INFO - (blobuploader) - INFO - Done attempting. 10:38:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:38:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:38:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:38:08 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:38:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:38:08 INFO - (blobuploader) - INFO - Done attempting. 10:38:08 INFO - (blobuploader) - INFO - Iteration through files over. 10:38:08 INFO - Return code: 0 10:38:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:38:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:38:08 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c635bc644ff662b801909f87df340a6b2b313aaab3d36d319ad4ea69d9ad11c2a9d3f7893dbf531d0c70be17437599595a9f25038ae21145bb572e5166c930a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26a4b8aaf9d0f88dbe47a94911840460bcbf435e19b45333ef05325b84376b9b61d96b02339e2fa18dc00e8efc0d93194713c8aa9f3022dad7e4fa128d695e25"} 10:38:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:38:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:38:08 INFO - Contents: 10:38:08 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c635bc644ff662b801909f87df340a6b2b313aaab3d36d319ad4ea69d9ad11c2a9d3f7893dbf531d0c70be17437599595a9f25038ae21145bb572e5166c930a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26a4b8aaf9d0f88dbe47a94911840460bcbf435e19b45333ef05325b84376b9b61d96b02339e2fa18dc00e8efc0d93194713c8aa9f3022dad7e4fa128d695e25"} 10:38:08 INFO - Running post-run listener: copy_logs_to_upload_dir 10:38:08 INFO - Copying logs to upload dir... 10:38:08 INFO - mkdir: /builds/slave/test/build/upload/logs 10:38:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1261.249522 ========= master_lag: 8.50 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 9 secs) (at 2016-02-23 10:38:16.907585) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 9 secs) (at 2016-02-23 10:38:16.911300) ========= 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.ZKCToJsGnO/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.w8g0hMwmks/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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/c635bc644ff662b801909f87df340a6b2b313aaab3d36d319ad4ea69d9ad11c2a9d3f7893dbf531d0c70be17437599595a9f25038ae21145bb572e5166c930a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26a4b8aaf9d0f88dbe47a94911840460bcbf435e19b45333ef05325b84376b9b61d96b02339e2fa18dc00e8efc0d93194713c8aa9f3022dad7e4fa128d695e25"} build_url:https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011362 build_url: 'https://queue.taskcluster.net/v1/task/WI-so8rzQPOEOPkkRb3DqA/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/c635bc644ff662b801909f87df340a6b2b313aaab3d36d319ad4ea69d9ad11c2a9d3f7893dbf531d0c70be17437599595a9f25038ae21145bb572e5166c930a0", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/26a4b8aaf9d0f88dbe47a94911840460bcbf435e19b45333ef05325b84376b9b61d96b02339e2fa18dc00e8efc0d93194713c8aa9f3022dad7e4fa128d695e25"}' ========= master_lag: 9.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 9 secs) (at 2016-02-23 10:38:25.943982) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 16 secs) (at 2016-02-23 10:38:25.944295) ========= 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.ZKCToJsGnO/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.w8g0hMwmks/Listeners TMPDIR=/var/folders/n5/8vlsdw_12tddqc4b5pnh50t000000w/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.005605 ========= master_lag: 16.37 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 16 secs) (at 2016-02-23 10:38:42.315037) ========= ========= Started reboot skipped (results: 3, elapsed: 2 secs) (at 2016-02-23 10:38:42.315409) ========= ========= Finished reboot skipped (results: 3, elapsed: 2 secs) (at 2016-02-23 10:38:44.964131) ========= ========= Total master_lag: 55.51 =========