builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0140 starttime: 1454953614.61 results: success (0) buildid: 20160208072230 builduid: b6e19e5fc0d7408bb1130965b1305633 revision: d007cfebe661581f8c70a818efa88b00e9da28af ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:54.606129) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:54.606752) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:54.607387) ========= 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.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.005517 basedir: '/builds/slave/test' ========= master_lag: 0.03 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:54.639475) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:54.639795) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:54.666455) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:54.666964) ========= 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.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005138 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:54.735601) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:54.739025) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:54.739454) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:54.739779) ========= 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.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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-08 09:46:54-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 8.43M=0.001s 2016-02-08 09:46:55 (8.43 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.462221 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:55.217549) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:55.221047) ========= 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.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.019201 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:55.274646) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-08 09:46:55.278093) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev d007cfebe661581f8c70a818efa88b00e9da28af --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev d007cfebe661581f8c70a818efa88b00e9da28af --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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-08 09:46:55,423 truncating revision to first 12 chars 2016-02-08 09:46:55,423 Setting DEBUG logging. 2016-02-08 09:46:55,423 attempt 1/10 2016-02-08 09:46:55,423 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/d007cfebe661?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-02-08 09:46:57,480 unpacking tar archive at: fx-team-d007cfebe661/testing/mozharness/ program finished with exit code 0 elapsedTime=2.304728 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 2 secs) (at 2016-02-08 09:46:57.598452) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:57.598786) ========= echo d007cfebe661581f8c70a818efa88b00e9da28af in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['echo', u'd007cfebe661581f8c70a818efa88b00e9da28af'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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 d007cfebe661581f8c70a818efa88b00e9da28af program finished with exit code 0 elapsedTime=0.004887 script_repo_revision: 'd007cfebe661581f8c70a818efa88b00e9da28af' ========= master_lag: 0.05 ========= ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:57.652186) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:57.652976) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-02-08 09:46:57.666928) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-02-08 09:46:57.667322) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 09:46:57 INFO - MultiFileLogger online at 20160208 09:46:57 in /builds/slave/test 09:46:57 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 09:46:57 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:46:57 INFO - {'append_to_log': False, 09:46:57 INFO - 'base_work_dir': '/builds/slave/test', 09:46:57 INFO - 'blob_upload_branch': 'Fx-Team', 09:46:57 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:46:57 INFO - 'branch': 'Fx-Team', 09:46:57 INFO - 'buildbot_json_path': 'buildprops.json', 09:46:57 INFO - 'config_files': ('talos/mac_config.py',), 09:46:57 INFO - 'default_actions': ('clobber', 09:46:57 INFO - 'read-buildbot-config', 09:46:57 INFO - 'download-and-extract', 09:46:57 INFO - 'populate-webroot', 09:46:57 INFO - 'create-virtualenv', 09:46:57 INFO - 'install', 09:46:57 INFO - 'run-tests'), 09:46:57 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:46:57 INFO - 'download_minidump_stackwalk': True, 09:46:57 INFO - 'download_symbols': 'ondemand', 09:46:57 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:46:57 INFO - 'tooltool.py': '/tools/tooltool.py', 09:46:57 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:46:57 INFO - '/tools/misc-python/virtualenv.py')}, 09:46:57 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:46:57 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:46:57 INFO - 'installer_path': 'installer.exe', 09:46:57 INFO - 'log_level': 'info', 09:46:57 INFO - 'log_name': 'talos', 09:46:57 INFO - 'log_to_console': True, 09:46:57 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:46:57 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:46:57 INFO - 'opt_config_files': (), 09:46:57 INFO - 'pip_index': False, 09:46:57 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:46:57 INFO - 'cmd': ('bash', 09:46:57 INFO - '-c', 09:46:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:46:57 INFO - 'enabled': True, 09:46:57 INFO - 'halt_on_failure': False, 09:46:57 INFO - 'name': 'check_screen_resolution'},), 09:46:57 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:46:57 INFO - 'cmd': ('bash', 09:46:57 INFO - '-c', 09:46:57 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:46:57 INFO - 'enabled': True, 09:46:57 INFO - 'halt_on_failure': False, 09:46:57 INFO - 'name': 'check_screen_resolution'},), 09:46:57 INFO - 'run_cmd_checks_enabled': True, 09:46:57 INFO - 'sps_profile': False, 09:46:57 INFO - 'sps_profile_interval': 0, 09:46:57 INFO - 'suite': 'dromaeojs-e10s', 09:46:57 INFO - 'system_bits': '32', 09:46:57 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:46:57 INFO - 'title': 't-yosemite-r7-0140', 09:46:57 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:46:57 INFO - 'use_talos_json': True, 09:46:57 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:46:57 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:46:57 INFO - 'work_dir': 'build'} 09:46:57 INFO - ##### 09:46:57 INFO - ##### Running clobber step. 09:46:57 INFO - ##### 09:46:57 INFO - Running pre-action listener: _resource_record_pre_action 09:46:57 INFO - Running main action method: clobber 09:46:57 INFO - rmtree: /builds/slave/test/build 09:46:57 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:46:59 INFO - Running post-action listener: _resource_record_post_action 09:46:59 INFO - ##### 09:46:59 INFO - ##### Running read-buildbot-config step. 09:46:59 INFO - ##### 09:46:59 INFO - Running pre-action listener: _resource_record_pre_action 09:46:59 INFO - Running main action method: read_buildbot_config 09:46:59 INFO - Using buildbot properties: 09:46:59 INFO - { 09:46:59 INFO - "project": "", 09:46:59 INFO - "product": "firefox", 09:46:59 INFO - "script_repo_revision": "production", 09:46:59 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 09:46:59 INFO - "repository": "", 09:46:59 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 09:46:59 INFO - "buildid": "20160208072230", 09:46:59 INFO - "pgo_build": "False", 09:46:59 INFO - "basedir": "/builds/slave/test", 09:46:59 INFO - "buildnumber": 345, 09:46:59 INFO - "slavename": "t-yosemite-r7-0140", 09:46:59 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:46:59 INFO - "platform": "yosemite_r7", 09:46:59 INFO - "scheduler": "tests-fx-team-macosx64-talos", 09:46:59 INFO - "branch": "fx-team", 09:46:59 INFO - "repo_path": "integration/fx-team", 09:46:59 INFO - "revision": "d007cfebe661581f8c70a818efa88b00e9da28af", 09:46:59 INFO - "stage_platform": "macosx64", 09:46:59 INFO - "builduid": "b6e19e5fc0d7408bb1130965b1305633", 09:46:59 INFO - "slavebuilddir": "test" 09:46:59 INFO - } 09:46:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg. 09:46:59 INFO - Running post-action listener: _resource_record_post_action 09:46:59 INFO - ##### 09:46:59 INFO - ##### Running download-and-extract step. 09:46:59 INFO - ##### 09:46:59 INFO - Running pre-action listener: _resource_record_pre_action 09:46:59 INFO - Running main action method: download_and_extract 09:46:59 INFO - mkdir: /builds/slave/test/build/tests 09:46:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:46:59 INFO - https://queue.taskcluster.net/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 09:46:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/test_packages.json 09:46:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/test_packages.json 09:46:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 09:46:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 09:47:12 INFO - Downloaded 1277 bytes. 09:47:12 INFO - Reading from file /builds/slave/test/build/test_packages.json 09:47:12 INFO - Using the following test package requirements: 09:47:12 INFO - {u'common': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:47:12 INFO - u'cppunittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:47:12 INFO - u'firefox-47.0a1.en-US.mac.cppunittest.tests.zip'], 09:47:12 INFO - u'gtest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:47:12 INFO - u'firefox-47.0a1.en-US.mac.gtest.tests.zip'], 09:47:12 INFO - u'jittest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:47:12 INFO - u'jsshell-mac.zip'], 09:47:12 INFO - u'mochitest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:47:12 INFO - u'firefox-47.0a1.en-US.mac.mochitest.tests.zip'], 09:47:12 INFO - u'mozbase': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:47:12 INFO - u'reftest': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:47:12 INFO - u'firefox-47.0a1.en-US.mac.reftest.tests.zip'], 09:47:12 INFO - u'talos': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:47:12 INFO - u'firefox-47.0a1.en-US.mac.talos.tests.zip'], 09:47:12 INFO - u'web-platform': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:47:12 INFO - u'firefox-47.0a1.en-US.mac.web-platform.tests.zip'], 09:47:12 INFO - u'webapprt': [u'firefox-47.0a1.en-US.mac.common.tests.zip'], 09:47:12 INFO - u'xpcshell': [u'firefox-47.0a1.en-US.mac.common.tests.zip', 09:47:12 INFO - u'firefox-47.0a1.en-US.mac.xpcshell.tests.zip']} 09:47:12 INFO - Downloading packages: [u'firefox-47.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:47:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:12 INFO - https://queue.taskcluster.net/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:47:12 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:47:12 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:47:12 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/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 09:47:12 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/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 09:47:15 INFO - Downloaded 17753499 bytes. 09:47: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'] 09:47: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 09:47:18 INFO - Return code: 0 09:47:18 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 09:47: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')]} 09:47:18 INFO - https://queue.taskcluster.net/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 09:47:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:47:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.common.tests.zip 09:47:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/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 09:47:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/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 09:47:19 INFO - Downloaded 17753499 bytes. 09:47:19 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'] 09:47:19 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 09:47:23 INFO - Return code: 0 09:47:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:23 INFO - https://queue.taskcluster.net/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 09:47:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:47:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.talos.tests.zip 09:47:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/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 09:47:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/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 09:47:23 INFO - Downloaded 10706547 bytes. 09:47:23 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'] 09:47:23 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 09:47:24 INFO - Return code: 0 09:47:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:24 INFO - https://queue.taskcluster.net/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 09:47:24 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:47:24 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:47:24 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-47.0a1.en-US.mac.dmg 09:47:24 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/B-xOeHQORRiffk3EvVWfyg/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 09:47:29 INFO - Downloaded 111839482 bytes. 09:47:29 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:47:29 INFO - mkdir: /builds/slave/test/properties 09:47:29 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:47:29 INFO - Writing to file /builds/slave/test/properties/build_url 09:47:29 INFO - Contents: 09:47:29 INFO - build_url:https://queue.taskcluster.net/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg 09:47:30 INFO - Running post-action listener: _resource_record_post_action 09:47:30 INFO - Running post-action listener: set_extra_try_arguments 09:47:30 INFO - ##### 09:47:30 INFO - ##### Running populate-webroot step. 09:47:30 INFO - ##### 09:47:30 INFO - Running pre-action listener: _resource_record_pre_action 09:47:30 INFO - Running main action method: populate_webroot 09:47:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:47:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:47:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:47:30 INFO - '--tppagecycles', 09:47:30 INFO - '7'], 09:47:30 INFO - 'tests': ['tsvgm']}}, 09:47:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 09:47:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 09:47:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:47:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken']}, 09:47:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 09:47:30 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:47:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:47:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:30 INFO - 'talos_options': ['--e10s'], 09:47:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:47:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:30 INFO - 'tests': ['damp', 'tps']}, 09:47:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:30 INFO - 'talos_options': ['--e10s'], 09:47:30 INFO - 'tests': ['damp', 'tps']}, 09:47:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 09:47:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:47:30 INFO - 'other': {'tests': ['a11yr', 09:47:30 INFO - 'ts_paint', 09:47:30 INFO - 'tpaint', 09:47:30 INFO - 'sessionrestore', 09:47:30 INFO - 'sessionrestore_no_auto_restore']}, 09:47:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 09:47:30 INFO - 'tests': ['a11yr', 09:47:30 INFO - 'ts_paint', 09:47:30 INFO - 'tpaint', 09:47:30 INFO - 'sessionrestore', 09:47:30 INFO - 'sessionrestore_no_auto_restore']}, 09:47:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 09:47:30 INFO - 'tests': ['a11yr', 09:47:30 INFO - 'ts_paint', 09:47:30 INFO - 'tpaint', 09:47:30 INFO - 'sessionrestore', 09:47:30 INFO - 'sessionrestore_no_auto_restore']}, 09:47:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 09:47:30 INFO - 'tests': ['a11yr', 09:47:30 INFO - 'ts_paint', 09:47:30 INFO - 'tpaint', 09:47:30 INFO - 'sessionrestore', 09:47:30 INFO - 'sessionrestore_no_auto_restore']}, 09:47:30 INFO - 'other_l64': {'tests': ['a11yr', 09:47:30 INFO - 'ts_paint', 09:47:30 INFO - 'tpaint', 09:47:30 INFO - 'sessionrestore', 09:47:30 INFO - 'sessionrestore_no_auto_restore']}, 09:47:30 INFO - 'other_nol64': {'tests': ['a11yr', 09:47:30 INFO - 'ts_paint', 09:47:30 INFO - 'tpaint', 09:47:30 INFO - 'sessionrestore', 09:47:30 INFO - 'sessionrestore_no_auto_restore']}, 09:47:30 INFO - 'svgr': {'tests': ['tsvgx', 09:47:30 INFO - 'tsvgr_opacity', 09:47:30 INFO - 'tart', 09:47:30 INFO - 'tscrollx', 09:47:30 INFO - 'cart']}, 09:47:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 09:47:30 INFO - 'tests': ['tsvgx', 09:47:30 INFO - 'tsvgr_opacity', 09:47:30 INFO - 'tart', 09:47:30 INFO - 'tscrollx', 09:47:30 INFO - 'cart']}, 09:47:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:30 INFO - 'tests': ['tp5o']}, 09:47:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:30 INFO - 'talos_options': ['--e10s'], 09:47:30 INFO - 'tests': ['tp5o']}, 09:47:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:30 INFO - 'talos_options': ['--xperf_path', 09:47:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:47:30 INFO - 'tests': ['tp5n']}, 09:47:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 09:47:30 INFO - 'talos_options': ['--e10s', 09:47:30 INFO - '--xperf_path', 09:47:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:47:30 INFO - 'tests': ['tp5n']}}, 09:47:30 INFO - 'talos.zip': {'path': '', 09:47:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:47:30 INFO - Running post-action listener: _resource_record_post_action 09:47:30 INFO - ##### 09:47:30 INFO - ##### Running create-virtualenv step. 09:47:30 INFO - ##### 09:47:30 INFO - Running pre-action listener: _resource_record_pre_action 09:47:30 INFO - Running main action method: create_virtualenv 09:47:30 INFO - Creating virtualenv /builds/slave/test/build/venv 09:47:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 09:47:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:47:30 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:47:30 INFO - Using real prefix '/tools/python27' 09:47:30 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:47:31 INFO - Installing distribute.............................................................................................................................................................................................done. 09:47:34 INFO - Installing pip.................done. 09:47:34 INFO - Return code: 0 09:47:34 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:34 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 0x1060dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2b8d8e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f82d30>, '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 0x105da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f79b20>, '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.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:47:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:47:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3J6fzx4wd/Render', 09:47:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:34 INFO - 'HOME': '/Users/cltbld', 09:47:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:34 INFO - 'LOGNAME': 'cltbld', 09:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:34 INFO - 'MOZ_NO_REMOTE': '1', 09:47:34 INFO - 'NO_EM_RESTART': '1', 09:47:34 INFO - 'PAGER': '/bin/cat', 09:47:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:34 INFO - 'PWD': '/builds/slave/test', 09:47:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:34 INFO - 'SHELL': '/bin/bash', 09:47:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJVXjK6mAh/Listeners', 09:47:34 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:47:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:34 INFO - 'USER': 'cltbld', 09:47:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:34 INFO - 'XPC_FLAGS': '0x0', 09:47:34 INFO - 'XPC_SERVICE_NAME': '0', 09:47:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:34 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 09:47:34 INFO - Cleaning up... 09:47:34 INFO - Return code: 0 09:47:34 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 09:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:34 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 0x1060dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2b8d8e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f82d30>, '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 0x105da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f79b20>, '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.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:47:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 09:47:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 09:47:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3J6fzx4wd/Render', 09:47:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:34 INFO - 'HOME': '/Users/cltbld', 09:47:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:34 INFO - 'LOGNAME': 'cltbld', 09:47:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:34 INFO - 'MOZ_NO_REMOTE': '1', 09:47:34 INFO - 'NO_EM_RESTART': '1', 09:47:34 INFO - 'PAGER': '/bin/cat', 09:47:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:34 INFO - 'PWD': '/builds/slave/test', 09:47:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:34 INFO - 'SHELL': '/bin/bash', 09:47:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJVXjK6mAh/Listeners', 09:47:34 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:47:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:34 INFO - 'USER': 'cltbld', 09:47:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:34 INFO - 'XPC_FLAGS': '0x0', 09:47:34 INFO - 'XPC_SERVICE_NAME': '0', 09:47:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:34 INFO - Downloading/unpacking psutil>=0.7.1 09:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:47:37 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:47:37 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:47:37 INFO - Installing collected packages: psutil 09:47:37 INFO - Running setup.py install for psutil 09:47:38 INFO - building 'psutil._psutil_osx' extension 09:47:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 09:47:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 09:47:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:47:38 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 09:47:38 INFO - building 'psutil._psutil_posix' extension 09:47:38 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 09:47:38 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:47:38 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:47:38 INFO - ^ 09:47:38 INFO - 1 warning generated. 09:47:38 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 09:47:38 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:47:38 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:47:38 INFO - Successfully installed psutil 09:47:38 INFO - Cleaning up... 09:47:38 INFO - Return code: 0 09:47:38 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 09:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:38 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 0x1060dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2b8d8e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f82d30>, '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 0x105da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f79b20>, '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.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:47:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 09:47:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 09:47:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3J6fzx4wd/Render', 09:47:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:38 INFO - 'HOME': '/Users/cltbld', 09:47:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:38 INFO - 'LOGNAME': 'cltbld', 09:47:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:38 INFO - 'MOZ_NO_REMOTE': '1', 09:47:38 INFO - 'NO_EM_RESTART': '1', 09:47:38 INFO - 'PAGER': '/bin/cat', 09:47:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:38 INFO - 'PWD': '/builds/slave/test', 09:47:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:38 INFO - 'SHELL': '/bin/bash', 09:47:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJVXjK6mAh/Listeners', 09:47:38 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:47:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:38 INFO - 'USER': 'cltbld', 09:47:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:38 INFO - 'XPC_FLAGS': '0x0', 09:47:38 INFO - 'XPC_SERVICE_NAME': '0', 09:47:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:39 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 09:47: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 09:47: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 09:47: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 09:47: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 09:47: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 09:47: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 09:47:41 INFO - Downloading mozsystemmonitor-0.0.tar.gz 09:47:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:47:41 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 09:47:41 INFO - Installing collected packages: mozsystemmonitor 09:47:41 INFO - Running setup.py install for mozsystemmonitor 09:47:41 INFO - Successfully installed mozsystemmonitor 09:47:41 INFO - Cleaning up... 09:47:41 INFO - Return code: 0 09:47:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:41 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 0x1060dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2b8d8e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f82d30>, '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 0x105da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f79b20>, '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.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:47:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 09:47:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 09:47:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3J6fzx4wd/Render', 09:47:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:41 INFO - 'HOME': '/Users/cltbld', 09:47:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:41 INFO - 'LOGNAME': 'cltbld', 09:47:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:41 INFO - 'MOZ_NO_REMOTE': '1', 09:47:41 INFO - 'NO_EM_RESTART': '1', 09:47:41 INFO - 'PAGER': '/bin/cat', 09:47:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:41 INFO - 'PWD': '/builds/slave/test', 09:47:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:41 INFO - 'SHELL': '/bin/bash', 09:47:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJVXjK6mAh/Listeners', 09:47:41 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:47:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:41 INFO - 'USER': 'cltbld', 09:47:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:41 INFO - 'XPC_FLAGS': '0x0', 09:47:41 INFO - 'XPC_SERVICE_NAME': '0', 09:47:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:42 INFO - Downloading/unpacking blobuploader==1.2.4 09:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:44 INFO - Downloading blobuploader-1.2.4.tar.gz 09:47:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:47:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:47:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:45 INFO - Downloading docopt-0.6.1.tar.gz 09:47:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:47:45 INFO - Installing collected packages: blobuploader, requests, docopt 09:47:45 INFO - Running setup.py install for blobuploader 09:47:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:47:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:47:45 INFO - Running setup.py install for requests 09:47:46 INFO - Running setup.py install for docopt 09:47:46 INFO - Successfully installed blobuploader requests docopt 09:47:46 INFO - Cleaning up... 09:47:46 INFO - Return code: 0 09:47:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:46 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 0x1060dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2b8d8e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f82d30>, '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 0x105da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f79b20>, '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.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:47:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:47:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:47:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3J6fzx4wd/Render', 09:47:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:46 INFO - 'HOME': '/Users/cltbld', 09:47:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:46 INFO - 'LOGNAME': 'cltbld', 09:47:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:46 INFO - 'MOZ_NO_REMOTE': '1', 09:47:46 INFO - 'NO_EM_RESTART': '1', 09:47:46 INFO - 'PAGER': '/bin/cat', 09:47:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:46 INFO - 'PWD': '/builds/slave/test', 09:47:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:46 INFO - 'SHELL': '/bin/bash', 09:47:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJVXjK6mAh/Listeners', 09:47:46 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:47:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:46 INFO - 'USER': 'cltbld', 09:47:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:46 INFO - 'XPC_FLAGS': '0x0', 09:47:46 INFO - 'XPC_SERVICE_NAME': '0', 09:47:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:47:46 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-SjUe1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:47:46 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-KCydfM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:47:46 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-wwYOOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:47:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:47:46 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-x0P617-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:47:47 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-wqVMKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:47:47 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-NMKitf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:47:47 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-m41PfT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:47:47 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-za6hem-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:47:47 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-6dgTdV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:47:47 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-TMiAlJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:47:47 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-v9uWyR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:47:47 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Je68oC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:47:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:47:47 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-3gsBsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:47:48 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-gU3SRv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:48 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-NE69g4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:47:48 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-weQNeY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:47:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:47:48 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-II1EYs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:47:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:47:48 INFO - Running setup.py install for manifestparser 09:47:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:47:48 INFO - Running setup.py install for mozcrash 09:47:48 INFO - Running setup.py install for mozdebug 09:47:48 INFO - Running setup.py install for mozdevice 09:47:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 09:47:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:47:49 INFO - Running setup.py install for mozfile 09:47:49 INFO - Running setup.py install for mozhttpd 09:47:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:47:49 INFO - Running setup.py install for mozinfo 09:47:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:47:49 INFO - Running setup.py install for mozInstall 09:47:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:47:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:47:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:47:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:47:49 INFO - Running setup.py install for mozleak 09:47:49 INFO - Running setup.py install for mozlog 09:47:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:47:49 INFO - Running setup.py install for moznetwork 09:47:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:47:50 INFO - Running setup.py install for mozprocess 09:47:50 INFO - Running setup.py install for mozprofile 09:47:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:47:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:47:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:47:50 INFO - Running setup.py install for mozrunner 09:47:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:47:50 INFO - Running setup.py install for mozscreenshot 09:47:50 INFO - Running setup.py install for moztest 09:47:50 INFO - Running setup.py install for mozversion 09:47:50 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:47:50 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:47:50 INFO - Cleaning up... 09:47:50 INFO - Return code: 0 09:47:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:50 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 0x1060dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2b8d8e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f82d30>, '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 0x105da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f79b20>, '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.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:47:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 09:47:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:47:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3J6fzx4wd/Render', 09:47:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:50 INFO - 'HOME': '/Users/cltbld', 09:47:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:50 INFO - 'LOGNAME': 'cltbld', 09:47:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:50 INFO - 'MOZ_NO_REMOTE': '1', 09:47:50 INFO - 'NO_EM_RESTART': '1', 09:47:50 INFO - 'PAGER': '/bin/cat', 09:47:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:50 INFO - 'PWD': '/builds/slave/test', 09:47:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:50 INFO - 'SHELL': '/bin/bash', 09:47:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJVXjK6mAh/Listeners', 09:47:50 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:47:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:50 INFO - 'USER': 'cltbld', 09:47:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:50 INFO - 'XPC_FLAGS': '0x0', 09:47:50 INFO - 'XPC_SERVICE_NAME': '0', 09:47:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:47:51 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-Oy1e5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:47:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 09:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:47:51 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-etIX5r-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:47:51 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)) 09:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:47:51 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-2e3xpo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:47:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:47:51 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-5Kid8i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:47:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:47:51 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-QZXkKJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:47:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 09:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:47:51 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-cD75zW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:47:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 09:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:47:51 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-3EIC1W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:47:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 09:47:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:47:51 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-HkUnyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 09:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:47:52 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-2fhT7T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 09:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:47:52 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-BUZLIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:47:52 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-6fk96W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 09:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:47:52 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-dpM_QL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 09:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:47:52 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-k6cL57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 09:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:47:52 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-FYqbsz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 09:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:52 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-8vlG7R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 09:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:47:52 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-VecqzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:47:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 09:47:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:47:52 INFO - Running setup.py (path:/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/pip-DfZueo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 09:47:53 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)) 09:47:53 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)) 09:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 09:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:47:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:47:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:47: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 09:47: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 09:47: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 09:47: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 09:47: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 09:47: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 09:47:55 INFO - Downloading blessings-1.6.tar.gz 09:47:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:47:55 INFO - Installing collected packages: blessings 09:47:55 INFO - Running setup.py install for blessings 09:47:55 INFO - Successfully installed blessings 09:47:55 INFO - Cleaning up... 09:47:55 INFO - Return code: 0 09:47:55 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:47:55 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:47:55 INFO - Reading from file tmpfile_stdout 09:47:55 INFO - Current package versions: 09:47:55 INFO - blessings == 1.6 09:47:55 INFO - blobuploader == 1.2.4 09:47:55 INFO - docopt == 0.6.1 09:47:55 INFO - manifestparser == 1.1 09:47:55 INFO - mozInstall == 1.12 09:47:55 INFO - mozcrash == 0.16 09:47:55 INFO - mozdebug == 0.1 09:47:55 INFO - mozdevice == 0.48 09:47:55 INFO - mozfile == 1.2 09:47:55 INFO - mozhttpd == 0.7 09:47:55 INFO - mozinfo == 0.9 09:47:55 INFO - mozleak == 0.1 09:47:55 INFO - mozlog == 3.1 09:47:55 INFO - moznetwork == 0.27 09:47:55 INFO - mozprocess == 0.22 09:47:55 INFO - mozprofile == 0.28 09:47:55 INFO - mozrunner == 6.11 09:47:55 INFO - mozscreenshot == 0.1 09:47:55 INFO - mozsystemmonitor == 0.0 09:47:55 INFO - moztest == 0.7 09:47:55 INFO - mozversion == 1.4 09:47:55 INFO - psutil == 3.1.1 09:47:55 INFO - requests == 1.2.3 09:47:55 INFO - wsgiref == 0.1.2 09:47:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:55 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 0x1060dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2b8d8e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f82d30>, '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 0x105da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f79b20>, '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.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:47:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 09:47:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 09:47:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3J6fzx4wd/Render', 09:47:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:55 INFO - 'HOME': '/Users/cltbld', 09:47:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:55 INFO - 'LOGNAME': 'cltbld', 09:47:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:55 INFO - 'MOZ_NO_REMOTE': '1', 09:47:55 INFO - 'NO_EM_RESTART': '1', 09:47:55 INFO - 'PAGER': '/bin/cat', 09:47:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:55 INFO - 'PWD': '/builds/slave/test', 09:47:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:55 INFO - 'SHELL': '/bin/bash', 09:47:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJVXjK6mAh/Listeners', 09:47:55 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:47:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:55 INFO - 'USER': 'cltbld', 09:47:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:55 INFO - 'XPC_FLAGS': '0x0', 09:47:55 INFO - 'XPC_SERVICE_NAME': '0', 09:47:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 09:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 09:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 09:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 09:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 09:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 09:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 09:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 09:47:56 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 09:47:56 INFO - Cleaning up... 09:47:56 INFO - Return code: 0 09:47:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x1060dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2b8d8e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f82d30>, '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 0x105da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f79b20>, '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.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:47:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:47:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:47:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3J6fzx4wd/Render', 09:47:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:56 INFO - 'HOME': '/Users/cltbld', 09:47:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:56 INFO - 'LOGNAME': 'cltbld', 09:47:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:56 INFO - 'MOZ_NO_REMOTE': '1', 09:47:56 INFO - 'NO_EM_RESTART': '1', 09:47:56 INFO - 'PAGER': '/bin/cat', 09:47:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:56 INFO - 'PWD': '/builds/slave/test', 09:47:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:56 INFO - 'SHELL': '/bin/bash', 09:47:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJVXjK6mAh/Listeners', 09:47:56 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:47:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:56 INFO - 'USER': 'cltbld', 09:47:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:56 INFO - 'XPC_FLAGS': '0x0', 09:47:56 INFO - 'XPC_SERVICE_NAME': '0', 09:47:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:47:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:47:56 INFO - Downloading/unpacking jsonschema 09:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:58 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:47:58 INFO - Downloading/unpacking functools32 (from jsonschema) 09:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:58 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:58 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:47:58 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:47:58 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:47:59 INFO - Downloading functools32-3.2.3-2.tar.gz 09:47:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:47:59 INFO - warning: no files found matching '*.txt' 09:47:59 INFO - no previously-included directories found matching 'build' 09:47:59 INFO - no previously-included directories found matching 'dist' 09:47:59 INFO - no previously-included directories found matching '.git*' 09:47:59 INFO - Installing collected packages: jsonschema, functools32 09:47:59 INFO - Running setup.py install for functools32 09:47:59 INFO - warning: no files found matching '*.txt' 09:47:59 INFO - no previously-included directories found matching 'build' 09:47:59 INFO - no previously-included directories found matching 'dist' 09:47:59 INFO - no previously-included directories found matching '.git*' 09:47:59 INFO - Successfully installed jsonschema functools32 09:47:59 INFO - Cleaning up... 09:47:59 INFO - Return code: 0 09:47:59 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 09:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:47:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:47:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:47:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:47:59 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 0x1060dea30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060e54c8>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff2b8d8e190>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f82d30>, '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 0x105da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f79b20>, '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.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 09:47:59 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'flake8'] in /builds/slave/test/build 09:47:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub flake8 09:47:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3J6fzx4wd/Render', 09:47:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:47:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:47:59 INFO - 'HOME': '/Users/cltbld', 09:47:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:47:59 INFO - 'LOGNAME': 'cltbld', 09:47:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:47:59 INFO - 'MOZ_NO_REMOTE': '1', 09:47:59 INFO - 'NO_EM_RESTART': '1', 09:47:59 INFO - 'PAGER': '/bin/cat', 09:47:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:47:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:47:59 INFO - 'PWD': '/builds/slave/test', 09:47:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:47:59 INFO - 'SHELL': '/bin/bash', 09:47:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJVXjK6mAh/Listeners', 09:47:59 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:47:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:47:59 INFO - 'USER': 'cltbld', 09:47:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:47:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:47:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:47:59 INFO - 'XPC_FLAGS': '0x0', 09:47:59 INFO - 'XPC_SERVICE_NAME': '0', 09:47:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:48:00 INFO - Downloading/unpacking flake8 09:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:02 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 09:48:02 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 09:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:02 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:02 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:02 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:02 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:03 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 09:48:03 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 09:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:03 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 09:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:03 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:03 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:48:03 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:48:03 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:48:03 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 09:48:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:48:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:48:03 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:48:03 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:48:03 INFO - no previously-included directories found matching 'docs/_build' 09:48:03 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 09:48:04 INFO - Running setup.py install for pep8 09:48:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 09:48:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 09:48:04 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 09:48:04 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 09:48:04 INFO - no previously-included directories found matching 'docs/_build' 09:48:04 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 09:48:04 INFO - Successfully installed flake8 mccabe pyflakes pep8 09:48:04 INFO - Cleaning up... 09:48:04 INFO - Return code: 0 09:48:04 INFO - Running post-action listener: _resource_record_post_action 09:48:04 INFO - Running post-action listener: _start_resource_monitoring 09:48:04 INFO - Starting resource monitoring. 09:48:04 INFO - ##### 09:48:04 INFO - ##### Running install step. 09:48:04 INFO - ##### 09:48:04 INFO - Running pre-action listener: _resource_record_pre_action 09:48:04 INFO - Running main action method: install 09:48:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:48:04 INFO - Reading from file tmpfile_stdout 09:48:04 INFO - Detecting whether we're running mozinstall >=1.0... 09:48:04 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:48:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:48:04 INFO - Reading from file tmpfile_stdout 09:48:04 INFO - Output received: 09:48:04 INFO - Usage: mozinstall [options] installer 09:48:04 INFO - Options: 09:48:04 INFO - -h, --help show this help message and exit 09:48:04 INFO - -d DEST, --destination=DEST 09:48:04 INFO - Directory to install application into. [default: 09:48:04 INFO - "/builds/slave/test"] 09:48:04 INFO - --app=APP Application being installed. [default: firefox] 09:48:04 INFO - mkdir: /builds/slave/test/build/application 09:48:04 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'] 09:48:04 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 09:48:39 INFO - Reading from file tmpfile_stdout 09:48:39 INFO - Output received: 09:48:39 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:48:39 INFO - Running post-action listener: _resource_record_post_action 09:48:39 INFO - ##### 09:48:39 INFO - ##### Running run-tests step. 09:48:39 INFO - ##### 09:48:39 INFO - Running pre-action listener: _resource_record_pre_action 09:48:39 INFO - Running main action method: run_tests 09:48:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:48:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:48:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:48:39 INFO - 2016-02-08 09:48:39.092 screenresolution[1948:12196] starting screenresolution argv=screenresolution get 09:48:39 INFO - 2016-02-08 09:48:39.095 screenresolution[1948:12196] Display 0: 1600x1200x32@60 09:48:39 INFO - 2016-02-08 09:48:39.101 screenresolution[1949:12198] starting screenresolution argv=screenresolution list 09:48:39 INFO - Available Modes on Display 0 09:48:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:48:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:48:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:48:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:48:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:48:39 INFO - Intel Iris: 09:48:39 INFO - Chipset Model: Intel Iris 09:48:39 INFO - Type: GPU 09:48:39 INFO - Bus: Built-In 09:48:39 INFO - VRAM (Dynamic, Max): 1536 MB 09:48:39 INFO - Vendor: Intel (0x8086) 09:48:39 INFO - Device ID: 0x0a2e 09:48:39 INFO - Revision ID: 0x0009 09:48:39 INFO - Displays: 09:48:39 INFO - Display: 09:48:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:48:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:48:39 INFO - Display Serial Number: 1600x1200 60 09:48:39 INFO - Main Display: Yes 09:48:39 INFO - Mirror: Off 09:48:39 INFO - Online: Yes 09:48:39 INFO - Rotation: Supported 09:48:39 INFO - Return code: 0 09:48:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:48:39 INFO - Python 2.7.3 09:48:39 INFO - Return code: 0 09:48:39 INFO - grabbing minidump binary from tooltool 09:48:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 09:48:39 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 0x105f82d30>, '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 0x105da6db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105f79b20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:48:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 09:48:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 09:48:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:48:39 INFO - Return code: 0 09:48:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:48:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:48:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:48:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:48:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:48:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 09:48:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 09:48:40 INFO - Return code: 0 09:48:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 09:48:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0140 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 09:48:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.H3J6fzx4wd/Render', 09:48:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:48:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:48:40 INFO - 'HOME': '/Users/cltbld', 09:48:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:48:40 INFO - 'LOGNAME': 'cltbld', 09:48:40 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:48:40 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:48:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:48:40 INFO - 'MOZ_NO_REMOTE': '1', 09:48:40 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:48:40 INFO - 'NO_EM_RESTART': '1', 09:48:40 INFO - 'PAGER': '/bin/cat', 09:48:40 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:48:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:48:40 INFO - 'PWD': '/builds/slave/test', 09:48:40 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:48:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:48:40 INFO - 'SHELL': '/bin/bash', 09:48:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ZJVXjK6mAh/Listeners', 09:48:40 INFO - 'TMPDIR': '/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/', 09:48:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:48:40 INFO - 'USER': 'cltbld', 09:48:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:48:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:48:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:48:40 INFO - 'XPC_FLAGS': '0x0', 09:48:40 INFO - 'XPC_SERVICE_NAME': '0', 09:48:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:48:40 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0140', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 09:48:40 INFO - mozversion application_buildid: 20160208072230 09:48:40 INFO - mozversion application_changeset: d007cfebe661581f8c70a818efa88b00e9da28af 09:48:40 INFO - mozversion application_display_name: Nightly 09:48:40 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:48:40 INFO - mozversion application_name: Firefox 09:48:40 INFO - mozversion application_remotingname: firefox 09:48:40 INFO - mozversion application_repository: https://hg.mozilla.org/integration/fx-team 09:48:40 INFO - mozversion application_vendor: Mozilla 09:48:40 INFO - mozversion application_version: 47.0a1 09:48:40 INFO - mozversion platform_buildid: 20160208072230 09:48:40 INFO - mozversion platform_changeset: d007cfebe661581f8c70a818efa88b00e9da28af 09:48:40 INFO - mozversion platform_repository: https://hg.mozilla.org/integration/fx-team 09:48:40 INFO - mozversion platform_version: 47.0a1 09:48:40 INFO - using testdate: 1454953720 09:48:40 INFO - actual date: 1454953720 09:48:41 INFO - starting webserver on 'localhost:49615' 09:48:41 INFO - SUITE-START | Running 2 tests 09:48:41 INFO - TEST-START | dromaeo_css 09:48:41 INFO - operating with platform_type : mac_ 09:48:41 INFO - Initialising browser for dromaeo_css test... 09:48:41 INFO - TEST-INFO | started process 1967 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmp5uKiHx/profile http://localhost:49615/getInfo.html) 09:48:44 INFO - PROCESS | 1967 | __metrics Screen width/height:1600/1200 09:48:44 INFO - PROCESS | 1967 | colorDepth:24 09:48:44 INFO - PROCESS | 1967 | Browser inner width/height: 1024/689 09:48:44 INFO - PROCESS | 1967 | __metrics 09:48:44 INFO - PROCESS | 1967 | 09:48:44 INFO - PROCESS | 1967 | ###!!! [Child][MessageChannel] Error: (msgtype=0x2A0045,name=PBrowser::Msg___delete__) Channel closing: too late to send/recv, messages will be lost 09:48:44 INFO - PROCESS | 1967 | 09:48:44 INFO - TEST-INFO | 1967: exit 0 09:48:44 INFO - Browser initialized. 09:48:44 INFO - Running cycle 1/1 for dromaeo_css test... 09:48:44 INFO - TEST-INFO | started process 1971 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmp5uKiHx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:48:56 INFO - PROCESS | 1971 | RSS: Main: 259002368 09:48:56 INFO - PROCESS | 1971 | 09:49:46 INFO - PROCESS | 1971 | 1454953786419 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 09:51:57 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49615/tests/dromaeo/cssquery-ext.html) 09:51:58 INFO - PROCESS | 1971 | RSS: Main: 271515648 09:51:58 INFO - PROCESS | 1971 | 09:55:00 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-ext.html (next: http://localhost:49615/tests/dromaeo/cssquery-jquery.html) 09:55:00 INFO - PROCESS | 1971 | RSS: Main: 283729920 09:55:00 INFO - PROCESS | 1971 | 09:58:02 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49615/tests/dromaeo/cssquery-mootools.html) 09:58:03 INFO - PROCESS | 1971 | RSS: Main: 285188096 09:58:03 INFO - PROCESS | 1971 | 10:01:05 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49615/tests/dromaeo/cssquery-prototype.html) 10:01:05 INFO - PROCESS | 1971 | RSS: Main: 286904320 10:01:05 INFO - PROCESS | 1971 | 10:04:08 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49615/tests/dromaeo/cssquery-yui.html) 10:04:08 INFO - PROCESS | 1971 | RSS: Main: 288280576 10:04:08 INFO - PROCESS | 1971 | 10:07:11 INFO - PROCESS | 1971 | Cycle 1(1): loaded http://localhost:49615/tests/dromaeo/cssquery-yui.html (next: http://localhost:49615/tests/dromaeo/cssquery-dojo.html) 10:07:11 INFO - PROCESS | 1971 | RSS: Main: 291053568 10:07:11 INFO - PROCESS | 1971 | 10:07:11 INFO - PROCESS | 1971 | __start_tp_report 10:07:11 INFO - PROCESS | 1971 | _x_x_mozilla_page_load 10:07:11 INFO - PROCESS | 1971 | _x_x_mozilla_page_load_details 10:07:11 INFO - PROCESS | 1971 | |i|pagename|runs| 10:07:11 INFO - PROCESS | 1971 | |0;dojo.html;3406.523086767852;3567.554055743032;3589.8743543975966;3606.4770608261792;3606.6032736398993;5768.451997060278;5818.272715910512;5830.416958304168;5853.853653658661;5869.031609784392;5625.268715067035;5779.104238842976;5845.5908086433965;5871;5907.88184236315;4327.199468098396;5197.740112994354;5267.55225805807;5268.394134674504;5332.200169974515;991.0468351657568;5187.4034486034025;5262.578993680497;5298.36419629645;5334.679919204841;5235.895282094337;5271.235670827708;5271.65734227274;5285.947140528584;5288.2596436498925;5134.691918484903;5275.28783614211;5311.044012077825;5329.307190065306;5335.973320133413;5181.637285390024;5209.114450543417;5230.869228269324;5278.023565640369;5286.841394758163;5692.605311698619;5718.370979192286;5745.023346031185;5776.220210271602;5797.826065218051;6126.6017708848785;6231.844203894893;6294.842628934268;6295.338989406092;6326.588771729869;6283.7800676976085;6301.842453938688;6302.527310451735;6326.93673063268;6332.715027823759;5945.494632956161;5945.970270148665;5980.192673989;5985.700714964278;6006.729697163638;6211.751529938751;6284.842878928063;6320.115183874262;6387.776427825097;6389.3291204423795;6172.444479996821;6241.656708880964;6267.310595834455;6282.905756413566;6286.811395658046;5215.24378965048;6207.317195108534;6317.778877739257;6323.683815809191;6328.557001009977;6160.507159427235;6239.78160764371;6333.20834895638;6348.269948955929;6355.173827402408;6256.718447669866;6262.624242545462;6288.056791481223;6304.5586808922935;6323.747050117944;4891.095147397743;4903.926441103386;4973.925391119136;5013.047520971004;5061.898762024813;4468.754218518013;4505.932411013838;4522.66080043998;4532.229520981441;4538.52345503724;5919.911201331984;5940.6435613863305;5959;5972.134040564094;5972.58191926561;6206.751729930843;6251.093591429218;6297.370262973666;6318.842028949313;6349.55553111287;5862.794802181903;5890.175375447441;5930;5942.376050514634;5968.910466343008;5395.78416863321;5483.862903427446;5484;5490.066688662937;5507.7246137693755;6382.425581697669;6501.544891857619;6508.284088750233;6509.02364645307;6510.609363438209;6254.4996400286955;6274.905876411766;6285.214348206474;6300.401461861115;6320.525960553069;6283.214598175228;6392.169018027626;6482.481401487964;6499.480041596756;6527.379898909596;5644.983902897354;6270.372962703693;6294.7095845352505;6315.368463153648;6327.367263273636;4956.727379994135;5330.173823057432;5461.290032295776;5551.389347171888;6315.684215789101;6121.602095863755;6130.398136742091;6250.718717657807;6262.968685156545;6270.843228919313;6101.7559297627595;6151.231096112986;6167.6916154193;6186.659733714509;6273.498120150468;5342.492463215988;5702.486776190163;5952.494038006818;5964.284285885721;6192.752289908353;5132.692038477703;6182.28903676083;6214.316425193316;6215.595986260879;6261.24865016201;4983.775730092082;6131.938680613137;6159.507239420746;6169.537284703755;6179.536534760001 10:07:11 INFO - PROCESS | 1971 | |1;ext.html;440.2361902099858;528.873070463089;549.6592112890007;606.7087797857027;607.0378450156508;25729.87135064327;37860.43209351855;37978.430323545166;38037.23925521488;38062.42906356407;39267.80366098173;39286.21427571447;39719;39721.404178937264;39721.808345749676;9222.26221902248;9406.905930940671;9462.858057129148;9470.242380609534;9500.71497855062;9420.952895235549;9646.42121472714;9681.661141860037;9692.75768105796;9692.806143877118;9625.422474651508;9681.903180968171;9698.563564639608;9729.562169702345;9747;9607.4715890626;9671.371360861556;9706.320557560974;9726.854097188478;9729.075737804897;9470.810583788285;9542.188913942324;9566.90433095674;9571.090746379083;9574.186194173504;37981.43027854584;38145.42781858274;38212.61787382118;38362.61637383619;38496.80751596252;2788.247173263228;2808.396194818124;3057.327387974642;3233.401820663185;3390.627031026585;26883.924643014256;27206.911723531233;27334.45331093387;27392.315192120157;27401;2764.267469120685;2778.2220978126156;2804.1447358555633;2971.7919745617814;2984.3732816108645;377118;379774.10112949536;381182;381758;381926;56219.718901405235;65045.34954650393;65715.34284657188;65766;65879.34120658733;62096.68951655213;62968.37031629625;63220;63472.36527634757;63740;15404.845951540565;15429.45996890126;15467.767983480257;15545.84454155444;15607.297671604805;12179.939100304442;12485.87514124847;12510.999120070555;12546.05904557162;12562.309073001074;19657.01714914277;20573.279935202198;20580.691289630668;20592.58814823695;20683.58632827335;8802.295816334678;8988;9010.414323068979;9020.639174432948;9104.8634270486;879.9692010779592;959.3572306554626;998.311165295958;1083.7019819549687;1096.2545469081101;23743.762562374155;29467.85266073656;29488.530517862382;30182.84908575443;30594.69405305963;1002.7392877851811;1044.8693913260843;1173.8063219568846;1176.894079532829;1222.419350808359;15037.172955487553;15143.848561514244;15320.354964498736;15369.846301537065;15405.460808871636;537472;543557;544794;547353;550221;58031;58342.833143336895;58367.70816145892;58427;58478.83042339129;1414.0667159674772;1424.608232736006;1457.4680241711699;1468.3612628506635;1476.6677497563178;26729;29684.40631187321;30361.848190758905;30664;30890.53664195084;50451.49548504468;50607.49392506028;50937.981240375724;51083.74458127686;51239.97520049653;378904;379025;380301;380379;380788;28433.43133137284;30738.692613074476;30905.227369315948;30980.380392392475;31080.533791992686;43615;44761;45177.54822451733;45340.86647833831;46176.30735538902;34647.4802877952;35107.12232194216;35506;35819.82090089533;35897.820510897276;30022.84988575043;34978.65021349754;36061.37723802383;36516.452253216754;36694.44958325681;33641.99074027783;33745.3250934975;34707;34854.651453486156;34860.30279394449;30826.845865770527;31172.844135779174;31281.687183128786;31282.53076203904;31480.37039259156;20246;22355.32934011982;23950.760492394853;24086.916088775695;24553.63169552494 10:07:11 INFO - PROCESS | 1971 | |2;jquery.html;325.27139208173685;349.6975116524206;365.6946449714489;366.5747732630148;369.4329204670831;15546.22268886554;15570.844291557081;19544.31594894179;19942.800571994274;20874.165033398665;19289.13198906049;19568.412947611596;19635.920024398652;19752;19819.60360792783;5583.776648934048;5766.826995190151;5807.912881306784;5828.9417105828825;5836.533077353823;5511.889762204753;5701.57238207134;5760.135979603051;5768.3654797972185;5771.653700777946;3872.1674839909556;5562.637153897301;5697.74360153792;5837.270341207349;5841.094630332305;5800.651960882339;5839.649621022752;5859.707014649251;5865.794697185578;5889.381614930435;5388.110961691316;5596.300462442195;5619.915701264485;5624.072028115397;5666.631668941505;13085.214887106804;15750.44873429436;19161.520961975923;23459.296221113393;24159.87920060406;2150.9139634414605;2336.8013718833918;2550.5154020736;2717.836929784219;2774.1677496751095;9678.951605241999;9994;10675.78648427035;12088;13783.241921694304;1528.7019031288903;1739.6955532781712;1768.1601239411305;1789.2395731814056;1804.2422182683304;98393;99542;100604.99395006029;101411.98588014173;102309;8997.01032886382;10993.725156870982;11213.271137376045;11243.94378028121;11317;12740.617781466572;13180.472781088649;13374.799378009338;13424.194548326936;13455;7013.684384202723;8267.049289331684;8431.831363372821;8486.872696909551;8525.786855328543;8597.398182127192;8634.352423568258;8645.135486451305;8649.654013839376;8655.52394618302;4368.825246990148;4431.734095954189;4437.600615944516;4454.086912182995;4542.68201225911;1588.3408385519879;1875.493616723477;1890.0927554773787;1892.536328599502;1926.3931861463593;407.7023772645985;416.4897999950098;420.6487582868278;442.75302838096786;458.159277725371;11251.83122253167;11955.40222988847;12003.339816310187;12030.759384812254;19697.606047878962;711.8256027273247;760.3574979142616;835.4360806455618;897.4794619120894;947.3652652722692;9063.68277110298;10264.640737574298;10727.249092563601;10754.139668826476;10768.3538987661;385283;501216;616941;730682;750948;101382;102366;118525;118537.40731296288;122836;1177.270092542629;1198.161287099034;1198.5325722968223;1224.2715584227549;1236.202649291202;18357.3574924877;18605.534861628566;18643.161057752164;18711.88872504113;18997.715034274774;49120.75439622779;50107.24839127343;50523;51177;51252.74373628108;70256.94614580683;71346.07596582238;72857;73128;73146;7421.591812450151;7638.15980242184;7640.465167438226;7646.847063058819;7682.193369696325;10328.535215915152;10736.83894741564;11544.249623774427;11848.822267666164;11864.288142711119;7869.763907082796;7921.762347129596;9217.124373184537;10433.008864157893;10643.04212620837;9957.551910163915;10301.690949271533;10338.586456541654;10350.430726310125;10534.736631584272;9477.715668529956;10876.945615271872;10960.530911630965;10986.862023953005;11107.777844443228;7071.504994650325;7312.268773122645;7330.824271454702;7388.852222955618;7423.92576074254;8635.784105397415;8988.955055224682;10462.686119416125;10568.207384446043;10726.302790318605 10:07:11 INFO - PROCESS | 1971 | |3;mootools.html;1510.410939733504;1531.640064584822;1747.2748809244165;1850.2968871828703;1862.3761040051575;7788.883166752503;8465.322774178067;8620.913790862089;8829.42608730432;8839.425437346576;8528.317734581235;8558.400911936167;8651.69719059833;8709.695160669362;8724.781880452976;2445.6942882139733;2466.3094333586623;2467.3091534370405;2479.776820086192;2485.7887079598254;2426.0538390027905;2477.1949116537107;2479.417336925821;2493.0775613023206;2499.4376265340334;2160.8811515366647;2403.471236328005;2442.7312995570474;2442.864068208283;2461.9753802462014;2401.7117945846435;2413.227767114524;2451.350392146083;2464.6426268191103;2468.5309791139716;2431.3921519620094;2447.4248551590363;2450.6691596634405;2452.7424620414777;2455.594826853567;8519.48883067018;8580.013298470692;8590.828183436297;8607.784805379853;8627.956860215721;5246.108161612497;5442.210879422501;5474.206240095204;5477.835664930059;5480.04099282628;3739.0278527582755;3747.7563958342894;3753.39945608704;3766.868159614428;3777.301199278142;920.9631614735403;963.0754475703333;1023.4626820919077;1060.6234786650705;1105.4969988655143;11055.889441105566;11634.185607007514;11745.706357341049;11747.236429632132;11875.34685592292;4059.837606495766;4839.871798057066;4918.1393256180745;4969.875753106201;4982.427020892571;10124.341917775468;10182.541785619665;10228.284020118668;10236.948815255875;10248.692539223835;5454.645448045943;5468.425815289417;5495.543680924558;5496.697681627469;5504.889902201933;4924.089043526959;4943.950560494421;4950.2079667253065;4950.282209079735;4965.4289756678445;3971.0667993021616;3973.1854969731135;4008.1382502762044;4021.8190181441905;4029.9597004029583;1217.415640492551;1303.2571434282559;1306.6472052545948;1310.423413697989;1334.3928512526777;1062.6440142552176;1064.2497039587072;1095.742500512379;1206.7043574324346;1327.2169420042221;7844.137144914055;7879.921200788033;7934.682612695427;7967.3626109911065;8053.959730201312;999.8300288950895;1152.7752088342693;1155.2259985809528;1159.7042754097652;1170.6839153428527;6152.323244443108;6185.628862268189;6205.596636218631;6208.72060757267;6310.0534919761485;10009.949950250202;10542.841857372145;10602.787944241072;10642.988916052962;10663.146948244123;10318.226133039901;10481.685549433529;10485.423301718327;10554.577816887391;10555.947220264003;8177.591120443954;8196.42625016255;8252.793680157924;8278.254957053894;8295.7971094191;7672.232776722283;7794.596972544997;7810;7831.96084019599;7839.608019599112;9266.768330791785;9428.10433008863;9456.763580910532;9498.09768072032;9581.185599224144;9627.614895404105;9899.059589339002;9913.157381622643;9919.15687166599;9956.402615843073;7365.52124111931;7392.371648409945;7418.072740907387;7460.962695186489;7462.552246865205;6751.729930802713;8040.316573091352;8122.187781221831;8131.349492040505;8134.10524842255;5839.299284085937;7637;7681.1934746850775;7807.687692492464;7835.804104897195;6006.549508786946;6263.96868015657;7266.491345605757;7395.149557800922;7481.326680598772;7321.707131714672;7477.813054673677;7506.28690274423;7506.474546781673;7545.396368290633;5783.595148339576;6854.34883686049;6864.759733409307;6876.896846547406;6953.79138625842;6768.0863083485065;6830.419414349836;6976.511644184859;6988.231294557696;7001.684924178526 10:07:11 INFO - PROCESS | 1971 | |4;prototype.html;328.16973058162847;332.3005074318559;336.28371568558964;339.1639608365379;344.38871003967967;5637.238972738689;6836.658167091638;7049.3655570998535;7052.753153639624;7087.716491340347;7007.544509606884;7037.3666370026685;7066.540674856144;7117.501774875748;7120.893186602192;5196.29849970253;5197.896042079156;5202.089634313989;5213.86965325868;5215.40022897366;4809.951900480985;5214.400343960455;5214.817481388152;5216.6869987800665;5223.555997740177;4889.755512224392;4895.975520122394;4897.142999975008;4908.901821963558;4923.163062279403;4061.35018397058;4884.047610715894;4886.1204983103025;4904.852854414374;4912.7297998610065;4208.705390622657;4225.514065882432;4225.964638663547;4234.195502854448;4237.152569486115;6591.505637077191;6725.428338591226;6727.461803055793;6728.865422691568;6739.157605299338;5980.760769569256;5980.820575382745;5984.251968503937;6001.459868611802;6001.609895356788;7541.886871696929;7545.170031296553;7548.5848278344665;7553.546787192786;7562.546247225184;3837.76973381598;4061.5938406159444;4539.500654927955;4657.091867085919;4758.2386818108935;6473.870522589569;7724.961375193088;8017.158198389144;8035.839283214303;8039;4393.011572396185;4528.320751887178;4848.587870031087;4857.854264372075;4858.271259311132;4036.717429779946;4754.429468463806;4942.703437793743;4953.157963146274;4964.726940018261;4778.283257511332;4926.162552366106;5940.910886336708;6002.339742628307;6013.759449622054;6315.526335524854;7534.397248220129;7534.510256833289;7606.885896711554;7614.2766437188375;1700.766943965615;1722.7596130785814;1724.4998950304523;1733.5406117378905;1733.6966030944534;878.4377998081233;1091.1380009792333;1095.6603452929617;1099.054812860939;1108.6286094158386;6677.732890684319;6988.930110698828;6995.93004069963;7032.929670703227;7033.613151276729;6708.765193218214;7313;7792.922070779219;7834.921650783534;7843.098043724931;6016.548758843104;6560.867717991672;6947.7220911163995;6957.686904089328;6963.408110310579;3373.9662603374145;4141.772202528829;4146.979265103655;4153.397757325171;4160.521540022875;8051.597420129087;8147.185281471924;8149.79625509367;8161.469504482189;8164.387670924704;7863.515935478848;7990.280874721303;8024.638891249908;8044;8083.83832323362;8106.108328084024;8125.268725814587;8129.268365847102;8139.593020348959;8165.2243036911395;7611.923880761343;7799.337056350274;7805.18045605226;7833.882491762742;7987.520748755093;6340.9048864268;7718.807029824075;7733;7739.535627862347;7770.45606807518;6053.848653783691;8241.98071472493;8256.174382561696;8278.048024477263;8316.958415207886;4873.512648735098;4890.388701412324;4902.338184345068;4906.092372911023;4908.386451693538;6548.47612191014;6779.966100169468;7756.0304961879765;7885.2114788520685;7909.7231596893835;6208.844778880564;7404.777856664308;7578.431617628589;7594.278543538355;7687.846243074995;6467.353264673495;7553.924460755322;7566.508176968479;7577.848443030998;7586.696532138652;6599.878020736583;6907.481938854506;7385.778426647209;7427.183009868802;7455;7329.890051649123;7586.468947173645;7606.8098297543;7616.923830761843;7693.961530192313;7416.25837416254;7425.7029718810645;7428.665710042953;7439;7443.25567443273 10:07:11 INFO - PROCESS | 1971 | |5;yui.html;682.6006786030172;713.0908092182467;715.1406343506886;738.3686947659751;739.5562662402557;14728.337224824882;14773.261336933165;14828.258587070644;14848.406063757437;14859.554213373602;13543.525976590821;13763.518276860286;13902.026858119936;13914.721705565908;13915.930420347884;677.082553140495;847.4110493207239;851.5699571716275;851.5954921412341;869.5347988825979;859.5702148925537;869.3697069624503;871.8256348730248;871.8561437362828;876.701921346742;892.8214357128568;903.9005709371963;905.5155491811882;905.9728208153733;911.5806728904679;887.1173182683207;889.3774357949461;895.5566994337845;901.0088902207585;902.5757893789909;652.5301782716436;662.8707402056552;668.1547841979899;672.4855485553555;674.6120980436219;14521.419143234363;14638.560843174615;14695.338709758087;14749.705005899821;14816.481423150246;12697.746045079139;12736.745265094647;12740.108192426535;12893.67765805853;13261.933690331487;10002.899971000343;10143.25588827136;10459.110975567086;10559.841602375971;10878.510467029002;3988.900277493086;4040.1313717550574;4042;4099.795010249505;4117.238310912461;80082;80240.59879700623;81068.59465702693;81214.59392703058;81319.18680813235;7506.887396689054;9259.72220833376;9278.907210927939;9391.248700103975;9701;20549;20559.588808224053;20757;20826.583468330547;20869.478263043544;7606.847863042708;7685.730999414994;7719.189485103983;7800.835661532102;7877.172896845863;4074.5110586729784;4079.592040795956;4155.958440415558;4255.446791917093;4267.1892340455215;3364.091695242271;3384.221629025338;3385.864565417405;3408.079818449005;3412.351653185887;639.9616023038633;642.7975187815823;647.4787795824312;672.3612568060264;672.8856094463953;537.1888448442879;581.9156222347821;586.3930831589284;588.399832171183;619.7118339971935;8310.085890552034;8511.148885111439;8688.782780430414;8721.825563488695;8767.956160219286;559.6166625861217;599.3317451042057;606.6208619612742;612.5620181570199;626.3485974586379;3922.2547715933883;3959.7228194026143;4001.7198796083994;4102.5692302307825;4409.0520538084465;77372.61313693508;89076.5546172265;90489;99885.50057249668;100552.99447005583;64008.67995659992;64470.06589802313;67319;76600;78903.02742431485;51243.97512049738;51336.48663513317;69220.65389673019;69382.9592556112;70557;8808.867866981873;8828.470291782256;8865.734027979172;8960.19013666057;9017.2786177107;41574;49019.26471102865;49390.27134050291;49566.75216624038;49871;67237.66381168063;70042.29957700561;70193.64903175451;70451.29548704447;70799;10782.353058816496;10790.082842958436;10850.29473084247;11171.329720216812;11807.940960295144;11954.342511161969;12064.396780160781;12229.388530573258;12325.01399887989;12638.178518396275;11151.386673733023;11276.097912167172;11391.088712903114;11550.884491155317;11694.88305116972;11512.712182195177;11788.29270243788;11822.527098916291;11830.526778928746;11852;10757.085647720032;11268.549258029914;11502.712432189262;11526;12306.75386492283;9249.167574918021;9307.395019323721;9365.672201472917;9686.273529485175;9951.452670102924;9012.684556040507;9028.277737781093;9230.261579073524;9406.670766523139;9824.852627210455 10:07:11 INFO - PROCESS | 1971 | __end_tp_report 10:07:11 INFO - PROCESS | 1971 | __start_cc_report 10:07:11 INFO - PROCESS | 1971 | _x_x_mozilla_cycle_collect,378 10:07:11 INFO - PROCESS | 1971 | __end_cc_report 10:07:11 INFO - PROCESS | 1971 | __startTimestamp1454954831579__endTimestamp 10:07:11 INFO - PROCESS | 1971 | 10:07:11 INFO - PROCESS | 1971 | ------- Summary: start ------- 10:07:11 INFO - PROCESS | 1971 | Number of tests: 6 10:07:11 INFO - PROCESS | 1971 | 10:07:11 INFO - PROCESS | 1971 | [#0] dojo.html Cycles:165 Average:5761.36 Median:5972.58 stddev:747.67 (12.5%) stddev-sans-first:726.78 10:07:11 INFO - PROCESS | 1971 | Values: 3406.5 3567.6 3589.9 3606.5 3606.6 5768.5 5818.3 5830.4 5853.9 5869.0 5625.3 5779.1 5845.6 5871.0 5907.9 4327.2 5197.7 5267.6 5268.4 5332.2 991.0 5187.4 5262.6 5298.4 5334.7 5235.9 5271.2 5271.7 5285.9 5288.3 5134.7 5275.3 5311.0 5329.3 5336.0 5181.6 5209.1 5230.9 5278.0 5286.8 5692.6 5718.4 5745.0 5776.2 5797.8 6126.6 6231.8 6294.8 6295.3 6326.6 6283.8 6301.8 6302.5 6326.9 6332.7 5945.5 5946.0 5980.2 5985.7 6006.7 6211.8 6284.8 6320.1 6387.8 6389.3 6172.4 6241.7 6267.3 6282.9 6286.8 5215.2 6207.3 6317.8 6323.7 6328.6 6160.5 6239.8 6333.2 6348.3 6355.2 6256.7 6262.6 6288.1 6304.6 6323.7 4891.1 4903.9 4973.9 5013.0 5061.9 4468.8 4505.9 4522.7 4532.2 4538.5 5919.9 5940.6 5959.0 5972.1 5972.6 6206.8 6251.1 6297.4 6318.8 6349.6 5862.8 5890.2 5930.0 5942.4 5968.9 5395.8 5483.9 5484.0 5490.1 5507.7 6382.4 6501.5 6508.3 6509.0 6510.6 6254.5 6274.9 6285.2 6300.4 6320.5 6283.2 6392.2 6482.5 6499.5 6527.4 5645.0 6270.4 6294.7 6315.4 6327.4 4956.7 5330.2 5461.3 5551.4 6315.7 6121.6 6130.4 6250.7 6263.0 6270.8 6101.8 6151.2 6167.7 6186.7 6273.5 5342.5 5702.5 5952.5 5964.3 6192.8 5132.7 6182.3 6214.3 6215.6 6261.2 4983.8 6131.9 6159.5 6169.5 6179.5 10:07:11 INFO - PROCESS | 1971 | 10:07:11 INFO - PROCESS | 1971 | [#1] ext.html Cycles:180 Average:58465.72 Median:378964.50 stddev:117368.12 (31.0%) stddev-sans-first:117616.51 10:07:11 INFO - PROCESS | 1971 | Values: 440.2 528.9 549.7 606.7 607.0 25729.9 37860.4 37978.4 38037.2 38062.4 39267.8 39286.2 39719.0 39721.4 39721.8 9222.3 9406.9 9462.9 9470.2 9500.7 9421.0 9646.4 9681.7 9692.8 9692.8 9625.4 9681.9 9698.6 9729.6 9747.0 9607.5 9671.4 9706.3 9726.9 9729.1 9470.8 9542.2 9566.9 9571.1 9574.2 37981.4 38145.4 38212.6 38362.6 38496.8 2788.2 2808.4 3057.3 3233.4 3390.6 26883.9 27206.9 27334.5 27392.3 27401.0 2764.3 2778.2 2804.1 2971.8 2984.4 377118.0 379774.1 381182.0 381758.0 381926.0 56219.7 65045.3 65715.3 65766.0 65879.3 62096.7 62968.4 63220.0 63472.4 63740.0 15404.8 15429.5 15467.8 15545.8 15607.3 12179.9 12485.9 12511.0 12546.1 12562.3 19657.0 20573.3 20580.7 20592.6 20683.6 8802.3 8988.0 9010.4 9020.6 9104.9 880.0 959.4 998.3 1083.7 1096.3 23743.8 29467.9 29488.5 30182.8 30594.7 1002.7 1044.9 1173.8 1176.9 1222.4 15037.2 15143.8 15320.4 15369.8 15405.5 537472.0 543557.0 544794.0 547353.0 550221.0 58031.0 58342.8 58367.7 58427.0 58478.8 1414.1 1424.6 1457.5 1468.4 1476.7 26729.0 29684.4 30361.8 30664.0 30890.5 50451.5 50607.5 50938.0 51083.7 51240.0 378904.0 379025.0 380301.0 380379.0 380788.0 28433.4 30738.7 30905.2 30980.4 31080.5 43615.0 44761.0 45177.5 45340.9 46176.3 34647.5 35107.1 35506.0 35819.8 35897.8 30022.8 34978.7 36061.4 36516.5 36694.4 33642.0 33745.3 34707.0 34854.7 34860.3 30826.8 31172.8 31281.7 31282.5 31480.4 20246.0 22355.3 23950.8 24086.9 24553.6 10:07:11 INFO - PROCESS | 1971 | 10:07:11 INFO - PROCESS | 1971 | [#2] jquery.html Cycles:180 Average:33112.04 Median:368.00 stddev:101653.22 (27622.9%) stddev-sans-first:101908.57 10:07:11 INFO - PROCESS | 1971 | Values: 325.3 349.7 365.7 366.6 369.4 15546.2 15570.8 19544.3 19942.8 20874.2 19289.1 19568.4 19635.9 19752.0 19819.6 5583.8 5766.8 5807.9 5828.9 5836.5 5511.9 5701.6 5760.1 5768.4 5771.7 3872.2 5562.6 5697.7 5837.3 5841.1 5800.7 5839.6 5859.7 5865.8 5889.4 5388.1 5596.3 5619.9 5624.1 5666.6 13085.2 15750.4 19161.5 23459.3 24159.9 2150.9 2336.8 2550.5 2717.8 2774.2 9679.0 9994.0 10675.8 12088.0 13783.2 1528.7 1739.7 1768.2 1789.2 1804.2 98393.0 99542.0 100605.0 101412.0 102309.0 8997.0 10993.7 11213.3 11243.9 11317.0 12740.6 13180.5 13374.8 13424.2 13455.0 7013.7 8267.0 8431.8 8486.9 8525.8 8597.4 8634.4 8645.1 8649.7 8655.5 4368.8 4431.7 4437.6 4454.1 4542.7 1588.3 1875.5 1890.1 1892.5 1926.4 407.7 416.5 420.6 442.8 458.2 11251.8 11955.4 12003.3 12030.8 19697.6 711.8 760.4 835.4 897.5 947.4 9063.7 10264.6 10727.2 10754.1 10768.4 385283.0 501216.0 616941.0 730682.0 750948.0 101382.0 102366.0 118525.0 118537.4 122836.0 1177.3 1198.2 1198.5 1224.3 1236.2 18357.4 18605.5 18643.2 18711.9 18997.7 49120.8 50107.2 50523.0 51177.0 51252.7 70256.9 71346.1 72857.0 73128.0 73146.0 7421.6 7638.2 7640.5 7646.8 7682.2 10328.5 10736.8 11544.2 11848.8 11864.3 7869.8 7921.8 9217.1 10433.0 10643.0 9957.6 10301.7 10338.6 10350.4 10534.7 9477.7 10876.9 10960.5 10986.9 11107.8 7071.5 7312.3 7330.8 7388.9 7423.9 8635.8 8989.0 10462.7 10568.2 10726.3 10:07:11 INFO - PROCESS | 1971 | 10:07:11 INFO - PROCESS | 1971 | [#3] mootools.html Cycles:180 Average:5983.96 Median:5471.32 stddev:3126.30 (57.1%) stddev-sans-first:3116.99 10:07:11 INFO - PROCESS | 1971 | Values: 1510.4 1531.6 1747.3 1850.3 1862.4 7788.9 8465.3 8620.9 8829.4 8839.4 8528.3 8558.4 8651.7 8709.7 8724.8 2445.7 2466.3 2467.3 2479.8 2485.8 2426.1 2477.2 2479.4 2493.1 2499.4 2160.9 2403.5 2442.7 2442.9 2462.0 2401.7 2413.2 2451.4 2464.6 2468.5 2431.4 2447.4 2450.7 2452.7 2455.6 8519.5 8580.0 8590.8 8607.8 8628.0 5246.1 5442.2 5474.2 5477.8 5480.0 3739.0 3747.8 3753.4 3766.9 3777.3 921.0 963.1 1023.5 1060.6 1105.5 11055.9 11634.2 11745.7 11747.2 11875.3 4059.8 4839.9 4918.1 4969.9 4982.4 10124.3 10182.5 10228.3 10236.9 10248.7 5454.6 5468.4 5495.5 5496.7 5504.9 4924.1 4944.0 4950.2 4950.3 4965.4 3971.1 3973.2 4008.1 4021.8 4030.0 1217.4 1303.3 1306.6 1310.4 1334.4 1062.6 1064.2 1095.7 1206.7 1327.2 7844.1 7879.9 7934.7 7967.4 8054.0 999.8 1152.8 1155.2 1159.7 1170.7 6152.3 6185.6 6205.6 6208.7 6310.1 10009.9 10542.8 10602.8 10643.0 10663.1 10318.2 10481.7 10485.4 10554.6 10555.9 8177.6 8196.4 8252.8 8278.3 8295.8 7672.2 7794.6 7810.0 7832.0 7839.6 9266.8 9428.1 9456.8 9498.1 9581.2 9627.6 9899.1 9913.2 9919.2 9956.4 7365.5 7392.4 7418.1 7461.0 7462.6 6751.7 8040.3 8122.2 8131.3 8134.1 5839.3 7637.0 7681.2 7807.7 7835.8 6006.5 6264.0 7266.5 7395.1 7481.3 7321.7 7477.8 7506.3 7506.5 7545.4 5783.6 6854.3 6864.8 6876.9 6953.8 6768.1 6830.4 6976.5 6988.2 7001.7 10:07:11 INFO - PROCESS | 1971 | 10:07:11 INFO - PROCESS | 1971 | [#4] prototype.html Cycles:180 Average:6034.29 Median:6734.01 stddev:2002.50 (29.7%) stddev-sans-first:1961.78 10:07:11 INFO - PROCESS | 1971 | Values: 328.2 332.3 336.3 339.2 344.4 5637.2 6836.7 7049.4 7052.8 7087.7 7007.5 7037.4 7066.5 7117.5 7120.9 5196.3 5197.9 5202.1 5213.9 5215.4 4810.0 5214.4 5214.8 5216.7 5223.6 4889.8 4896.0 4897.1 4908.9 4923.2 4061.4 4884.0 4886.1 4904.9 4912.7 4208.7 4225.5 4226.0 4234.2 4237.2 6591.5 6725.4 6727.5 6728.9 6739.2 5980.8 5980.8 5984.3 6001.5 6001.6 7541.9 7545.2 7548.6 7553.5 7562.5 3837.8 4061.6 4539.5 4657.1 4758.2 6473.9 7725.0 8017.2 8035.8 8039.0 4393.0 4528.3 4848.6 4857.9 4858.3 4036.7 4754.4 4942.7 4953.2 4964.7 4778.3 4926.2 5940.9 6002.3 6013.8 6315.5 7534.4 7534.5 7606.9 7614.3 1700.8 1722.8 1724.5 1733.5 1733.7 878.4 1091.1 1095.7 1099.1 1108.6 6677.7 6988.9 6995.9 7032.9 7033.6 6708.8 7313.0 7792.9 7834.9 7843.1 6016.5 6560.9 6947.7 6957.7 6963.4 3374.0 4141.8 4147.0 4153.4 4160.5 8051.6 8147.2 8149.8 8161.5 8164.4 7863.5 7990.3 8024.6 8044.0 8083.8 8106.1 8125.3 8129.3 8139.6 8165.2 7611.9 7799.3 7805.2 7833.9 7987.5 6340.9 7718.8 7733.0 7739.5 7770.5 6053.8 8242.0 8256.2 8278.0 8317.0 4873.5 4890.4 4902.3 4906.1 4908.4 6548.5 6780.0 7756.0 7885.2 7909.7 6208.8 7404.8 7578.4 7594.3 7687.8 6467.4 7553.9 7566.5 7577.8 7586.7 6599.9 6907.5 7385.8 7427.2 7455.0 7329.9 7586.5 7606.8 7616.9 7694.0 7416.3 7425.7 7428.7 7439.0 7443.3 10:07:11 INFO - PROCESS | 1971 | 10:07:11 INFO - PROCESS | 1971 | [#5] yui.html Cycles:180 Average:17867.58 Median:616.14 stddev:24861.62 (4035.1%) stddev-sans-first:24897.88 10:07:11 INFO - PROCESS | 1971 | Values: 682.6 713.1 715.1 738.4 739.6 14728.3 14773.3 14828.3 14848.4 14859.6 13543.5 13763.5 13902.0 13914.7 13915.9 677.1 847.4 851.6 851.6 869.5 859.6 869.4 871.8 871.9 876.7 892.8 903.9 905.5 906.0 911.6 887.1 889.4 895.6 901.0 902.6 652.5 662.9 668.2 672.5 674.6 14521.4 14638.6 14695.3 14749.7 14816.5 12697.7 12736.7 12740.1 12893.7 13261.9 10002.9 10143.3 10459.1 10559.8 10878.5 3988.9 4040.1 4042.0 4099.8 4117.2 80082.0 80240.6 81068.6 81214.6 81319.2 7506.9 9259.7 9278.9 9391.2 9701.0 20549.0 20559.6 20757.0 20826.6 20869.5 7606.8 7685.7 7719.2 7800.8 7877.2 4074.5 4079.6 4156.0 4255.4 4267.2 3364.1 3384.2 3385.9 3408.1 3412.4 640.0 642.8 647.5 672.4 672.9 537.2 581.9 586.4 588.4 619.7 8310.1 8511.1 8688.8 8721.8 8768.0 559.6 599.3 606.6 612.6 626.3 3922.3 3959.7 4001.7 4102.6 4409.1 77372.6 89076.6 90489.0 99885.5 100553.0 64008.7 64470.1 67319.0 76600.0 78903.0 51244.0 51336.5 69220.7 69383.0 70557.0 8808.9 8828.5 8865.7 8960.2 9017.3 41574.0 49019.3 49390.3 49566.8 49871.0 67237.7 70042.3 70193.6 70451.3 70799.0 10782.4 10790.1 10850.3 11171.3 11807.9 11954.3 12064.4 12229.4 12325.0 12638.2 11151.4 11276.1 11391.1 11550.9 11694.9 11512.7 11788.3 11822.5 11830.5 11852.0 10757.1 11268.5 11502.7 11526.0 12306.8 9249.2 9307.4 9365.7 9686.3 9951.5 9012.7 9028.3 9230.3 9406.7 9824.9 10:07:11 INFO - PROCESS | 1971 | -------- Summary: end -------- 10:07:11 INFO - PROCESS | 1971 | 10:07:12 INFO - TEST-INFO | 1971: exit 0 10:07:12 INFO - TEST-OK | dromaeo_css | took 1110772ms 10:07:12 INFO - TEST-START | kraken 10:07:12 INFO - operating with platform_type : mac_ 10:07:12 INFO - Initialising browser for kraken test... 10:07:12 INFO - TEST-INFO | started process 1977 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmphjH3gW/profile http://localhost:49615/getInfo.html) 10:07:14 INFO - PROCESS | 1977 | __metrics Screen width/height:1600/1200 10:07:14 INFO - PROCESS | 1977 | colorDepth:24 10:07:14 INFO - PROCESS | 1977 | Browser inner width/height: 1024/689 10:07:14 INFO - PROCESS | 1977 | __metrics 10:07:15 INFO - TEST-INFO | 1977: exit 0 10:07:15 INFO - Browser initialized. 10:07:15 INFO - Running cycle 1/1 for kraken test... 10:07:15 INFO - TEST-INFO | started process 1980 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/T/tmphjH3gW/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 10:07:27 INFO - PROCESS | 1980 | RSS: Main: 259133440 10:07:27 INFO - PROCESS | 1980 | 10:07:30 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49615/tests/kraken/driver.html?testName=audio-beat-detection) 10:07:31 INFO - PROCESS | 1980 | RSS: Main: 270655488 10:07:31 INFO - PROCESS | 1980 | 10:07:33 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49615/tests/kraken/driver.html?testName=audio-dft) 10:07:34 INFO - PROCESS | 1980 | RSS: Main: 278548480 10:07:34 INFO - PROCESS | 1980 | 10:07:37 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49615/tests/kraken/driver.html?testName=audio-fft) 10:07:38 INFO - PROCESS | 1980 | RSS: Main: 283664384 10:07:38 INFO - PROCESS | 1980 | 10:07:40 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49615/tests/kraken/driver.html?testName=audio-oscillator) 10:07:41 INFO - PROCESS | 1980 | RSS: Main: 282578944 10:07:41 INFO - PROCESS | 1980 | 10:07:43 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49615/tests/kraken/driver.html?testName=imaging-gaussian-blur) 10:07:43 INFO - PROCESS | 1980 | RSS: Main: 286842880 10:07:43 INFO - PROCESS | 1980 | 10:07:46 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49615/tests/kraken/driver.html?testName=imaging-darkroom) 10:07:47 INFO - PROCESS | 1980 | RSS: Main: 286310400 10:07:47 INFO - PROCESS | 1980 | 10:07:50 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49615/tests/kraken/driver.html?testName=imaging-desaturate) 10:07:50 INFO - PROCESS | 1980 | RSS: Main: 286117888 10:07:50 INFO - PROCESS | 1980 | 10:07:53 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49615/tests/kraken/driver.html?testName=json-parse-financial) 10:07:54 INFO - PROCESS | 1980 | RSS: Main: 286433280 10:07:54 INFO - PROCESS | 1980 | 10:07:55 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49615/tests/kraken/driver.html?testName=json-stringify-tinderbox) 10:07:56 INFO - PROCESS | 1980 | RSS: Main: 285556736 10:07:56 INFO - PROCESS | 1980 | 10:07:58 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-aes) 10:07:58 INFO - PROCESS | 1980 | RSS: Main: 285605888 10:07:58 INFO - PROCESS | 1980 | 10:08:00 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-ccm) 10:08:01 INFO - PROCESS | 1980 | RSS: Main: 286363648 10:08:01 INFO - PROCESS | 1980 | 10:08:03 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 10:08:04 INFO - PROCESS | 1980 | RSS: Main: 284704768 10:08:04 INFO - PROCESS | 1980 | 10:08:07 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 10:08:07 INFO - PROCESS | 1980 | RSS: Main: 284762112 10:08:07 INFO - PROCESS | 1980 | 10:08:09 INFO - PROCESS | 1980 | Cycle 1(1): loaded http://localhost:49615/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49615/tests/kraken/driver.html?testName=ai-astar) 10:08:09 INFO - PROCESS | 1980 | RSS: Main: 287801344 10:08:09 INFO - PROCESS | 1980 | 10:08:09 INFO - PROCESS | 1980 | __start_tp_report 10:08:09 INFO - PROCESS | 1980 | _x_x_mozilla_page_load 10:08:09 INFO - PROCESS | 1980 | _x_x_mozilla_page_load_details 10:08:09 INFO - PROCESS | 1980 | |i|pagename|runs| 10:08:09 INFO - PROCESS | 1980 | |0;ai-astar;111;107;97;143;106;169;167;167;114;113 10:08:09 INFO - PROCESS | 1980 | |1;audio-beat-detection;161;119;149;152;125;140;156;155;162;137 10:08:09 INFO - PROCESS | 1980 | |2;audio-dft;193;229;273;222;198;200;198;198;234;277 10:08:09 INFO - PROCESS | 1980 | |3;audio-fft;70;74;71;122;59;83;84;74;67;54 10:08:09 INFO - PROCESS | 1980 | |4;audio-oscillator;82;91;144;116;84;81;116;108;74;104 10:08:09 INFO - PROCESS | 1980 | |5;imaging-gaussian-blur;87;94;86;94;87;93;87;94;87;93 10:08:09 INFO - PROCESS | 1980 | |6;imaging-darkroom;154;153;97;97;95;95;96;95;97;98 10:08:09 INFO - PROCESS | 1980 | |7;imaging-desaturate;91;93;100;137;94;89;95;92;91;90 10:08:09 INFO - PROCESS | 1980 | |8;json-parse-financial;58;59;56;57;60;57;58;67;57;57 10:08:09 INFO - PROCESS | 1980 | |9;json-stringify-tinderbox;69;75;64;73;70;67;64;67;67;68 10:08:09 INFO - PROCESS | 1980 | |10;stanford-crypto-aes;98;112;116;84;85;84;86;86;84;87 10:08:09 INFO - PROCESS | 1980 | |11;stanford-crypto-ccm;126;130;128;123;122;127;128;138;125;125 10:08:09 INFO - PROCESS | 1980 | |12;stanford-crypto-pbkdf2;138;145;142;144;172;186;184;155;140;140 10:08:09 INFO - PROCESS | 1980 | |13;stanford-crypto-sha256-iterative;66;71;68;97;99;98;105;78;61;95 10:08:09 INFO - PROCESS | 1980 | __end_tp_report 10:08:09 INFO - PROCESS | 1980 | __start_cc_report 10:08:09 INFO - PROCESS | 1980 | _x_x_mozilla_cycle_collect,933 10:08:09 INFO - PROCESS | 1980 | __end_cc_report 10:08:09 INFO - PROCESS | 1980 | __startTimestamp1454954889953__endTimestamp 10:08:09 INFO - PROCESS | 1980 | 10:08:09 INFO - PROCESS | 1980 | ------- Summary: start ------- 10:08:09 INFO - PROCESS | 1980 | Number of tests: 14 10:08:09 INFO - PROCESS | 1980 | 10:08:09 INFO - PROCESS | 1980 | [#0] ai-astar Cycles:10 Average:129.40 Median:155.00 stddev:28.91 (18.7%) stddev-sans-first:29.89 10:08:09 INFO - PROCESS | 1980 | Values: 111.0 107.0 97.0 143.0 106.0 169.0 167.0 167.0 114.0 113.0 10:08:09 INFO - PROCESS | 1980 | 10:08:09 INFO - PROCESS | 1980 | [#1] audio-beat-detection Cycles:10 Average:145.60 Median:153.50 stddev:14.88 (9.7%) stddev-sans-first:14.70 10:08:09 INFO - PROCESS | 1980 | Values: 161.0 119.0 149.0 152.0 125.0 140.0 156.0 155.0 162.0 137.0 10:08:09 INFO - PROCESS | 1980 | 10:08:09 INFO - PROCESS | 1980 | [#2] audio-dft Cycles:10 Average:222.20 Median:225.50 stddev:31.40 (13.9%) stddev-sans-first:31.47 10:08:09 INFO - PROCESS | 1980 | Values: 193.0 229.0 273.0 222.0 198.0 200.0 198.0 198.0 234.0 277.0 10:08:09 INFO - PROCESS | 1980 | 10:08:09 INFO - PROCESS | 1980 | [#3] audio-fft Cycles:10 Average:75.80 Median:72.50 stddev:18.71 (25.8%) stddev-sans-first:19.73 10:08:09 INFO - PROCESS | 1980 | Values: 70.0 74.0 71.0 122.0 59.0 83.0 84.0 74.0 67.0 54.0 10:08:09 INFO - PROCESS | 1980 | 10:08:09 INFO - PROCESS | 1980 | [#4] audio-oscillator Cycles:10 Average:100.00 Median:77.50 stddev:21.67 (28.0%) stddev-sans-first:21.98 10:08:09 INFO - PROCESS | 1980 | Values: 82.0 91.0 144.0 116.0 84.0 81.0 116.0 108.0 74.0 104.0 10:08:09 INFO - PROCESS | 1980 | 10:08:09 INFO - PROCESS | 1980 | [#5] imaging-gaussian-blur Cycles:10 Average:90.20 Median:93.00 stddev:3.61 (3.9%) stddev-sans-first:3.64 10:08:09 INFO - PROCESS | 1980 | Values: 87.0 94.0 86.0 94.0 87.0 93.0 87.0 94.0 87.0 93.0 10:08:09 INFO - PROCESS | 1980 | 10:08:09 INFO - PROCESS | 1980 | [#6] imaging-darkroom Cycles:10 Average:107.70 Median:96.50 stddev:24.16 (25.0%) stddev-sans-first:18.95 10:08:09 INFO - PROCESS | 1980 | Values: 154.0 153.0 97.0 97.0 95.0 95.0 96.0 95.0 97.0 98.0 10:08:09 INFO - PROCESS | 1980 | 10:08:09 INFO - PROCESS | 1980 | [#7] imaging-desaturate Cycles:10 Average:97.20 Median:91.50 stddev:14.33 (15.7%) stddev-sans-first:15.02 10:08:09 INFO - PROCESS | 1980 | Values: 91.0 93.0 100.0 137.0 94.0 89.0 95.0 92.0 91.0 90.0 10:08:09 INFO - PROCESS | 1980 | 10:08:09 INFO - PROCESS | 1980 | [#8] json-parse-financial Cycles:10 Average:58.60 Median:58.00 stddev:3.17 (5.5%) stddev-sans-first:3.35 10:08:09 INFO - PROCESS | 1980 | Values: 58.0 59.0 56.0 57.0 60.0 57.0 58.0 67.0 57.0 57.0 10:08:09 INFO - PROCESS | 1980 | 10:08:09 INFO - PROCESS | 1980 | [#9] json-stringify-tinderbox Cycles:10 Average:68.40 Median:68.50 stddev:3.53 (5.2%) stddev-sans-first:3.74 10:08:09 INFO - PROCESS | 1980 | Values: 69.0 75.0 64.0 73.0 70.0 67.0 64.0 67.0 67.0 68.0 10:08:09 INFO - PROCESS | 1980 | 10:08:09 INFO - PROCESS | 1980 | [#10] stanford-crypto-aes Cycles:10 Average:92.20 Median:85.50 stddev:12.25 (14.3%) stddev-sans-first:12.81 10:08:09 INFO - PROCESS | 1980 | Values: 98.0 112.0 116.0 84.0 85.0 84.0 86.0 86.0 84.0 87.0 10:08:09 INFO - PROCESS | 1980 | 10:08:09 INFO - PROCESS | 1980 | [#11] stanford-crypto-ccm Cycles:10 Average:127.20 Median:127.50 stddev:4.49 (3.5%) stddev-sans-first:4.74 10:08:09 INFO - PROCESS | 1980 | Values: 126.0 130.0 128.0 123.0 122.0 127.0 128.0 138.0 125.0 125.0 10:08:09 INFO - PROCESS | 1980 | 10:08:09 INFO - PROCESS | 1980 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:154.60 Median:150.00 stddev:18.91 (12.6%) stddev-sans-first:19.08 10:08:09 INFO - PROCESS | 1980 | Values: 138.0 145.0 142.0 144.0 172.0 186.0 184.0 155.0 140.0 140.0 10:08:09 INFO - PROCESS | 1980 | 10:08:09 INFO - PROCESS | 1980 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:83.80 Median:86.50 stddev:16.55 (19.1%) stddev-sans-first:16.25 10:08:09 INFO - PROCESS | 1980 | Values: 66.0 71.0 68.0 97.0 99.0 98.0 105.0 78.0 61.0 95.0 10:08:09 INFO - PROCESS | 1980 | -------- Summary: end -------- 10:08:09 INFO - PROCESS | 1980 | 10:08:10 INFO - TEST-INFO | 1980: exit 0 10:08:10 INFO - TEST-OK | kraken | took 58587ms 10:08:10 INFO - SUITE-END | took 1169s 10:08:11 INFO - Completed test suite (00:19:29) 10:08:11 INFO - Working with test: dromaeo_css 10:08:11 INFO - Generating results file: dromaeo_css 10:08:11 INFO - Working with test: kraken 10:08:11 INFO - Generating results file: kraken 10:08:11 INFO - javascript benchmark 10:08:11 INFO - Posting result 0 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:08:11 INFO - process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 10:08:11 INFO - process_Request line: dromaeo_css 7472.56 graph.html#tests=[[72,64,61]] 10:08:11 INFO - Posting result 1 of 2 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 10:08:11 INFO - process_Request line: kraken 1552.90 graph.html#tests=[[232,64,61]] 10:08:11 INFO - RETURN: dromaeo_css: 7472.56 10:08:11 INFO - RETURN: kraken: 1552.90 10:08:11 INFO - javascript benchmark 10:08:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3406.523086767852, 3567.554055743032, 3589.8743543975966, 3606.4770608261792, 3606.6032736398993, 5768.451997060278, 5818.272715910512, 5830.416958304168, 5853.853653658661, 5869.031609784392, 5625.268715067035, 5779.104238842976, 5845.5908086433965, 5871.0, 5907.88184236315, 4327.199468098396, 5197.740112994354, 5267.55225805807, 5268.394134674504, 5332.200169974515, 991.0468351657568, 5187.4034486034025, 5262.578993680497, 5298.36419629645, 5334.679919204841, 5235.895282094337, 5271.235670827708, 5271.65734227274, 5285.947140528584, 5288.2596436498925, 5134.691918484903, 5275.28783614211, 5311.044012077825, 5329.307190065306, 5335.973320133413, 5181.637285390024, 5209.114450543417, 5230.869228269324, 5278.023565640369, 5286.841394758163, 5692.605311698619, 5718.370979192286, 5745.023346031185, 5776.220210271602, 5797.826065218051, 6126.6017708848785, 6231.844203894893, 6294.842628934268, 6295.338989406092, 6326.588771729869, 6283.7800676976085, 6301.842453938688, 6302.527310451735, 6326.93673063268, 6332.715027823759, 5945.494632956161, 5945.970270148665, 5980.192673989, 5985.700714964278, 6006.729697163638, 6211.751529938751, 6284.842878928063, 6320.115183874262, 6387.776427825097, 6389.3291204423795, 6172.444479996821, 6241.656708880964, 6267.310595834455, 6282.905756413566, 6286.811395658046, 5215.24378965048, 6207.317195108534, 6317.778877739257, 6323.683815809191, 6328.557001009977, 6160.507159427235, 6239.78160764371, 6333.20834895638, 6348.269948955929, 6355.173827402408, 6256.718447669866, 6262.624242545462, 6288.056791481223, 6304.5586808922935, 6323.747050117944, 4891.095147397743, 4903.926441103386, 4973.925391119136, 5013.047520971004, 5061.898762024813, 4468.754218518013, 4505.932411013838, 4522.66080043998, 4532.229520981441, 4538.52345503724, 5919.911201331984, 5940.6435613863305, 5959.0, 5972.134040564094, 5972.58191926561, 6206.751729930843, 6251.093591429218, 6297.370262973666, 6318.842028949313, 6349.55553111287, 5862.794802181903, 5890.175375447441, 5930.0, 5942.376050514634, 5968.910466343008, 5395.78416863321, 5483.862903427446, 5484.0, 5490.066688662937, 5507.7246137693755, 6382.425581697669, 6501.544891857619, 6508.284088750233, 6509.02364645307, 6510.609363438209, 6254.4996400286955, 6274.905876411766, 6285.214348206474, 6300.401461861115, 6320.525960553069, 6283.214598175228, 6392.169018027626, 6482.481401487964, 6499.480041596756, 6527.379898909596, 5644.983902897354, 6270.372962703693, 6294.7095845352505, 6315.368463153648, 6327.367263273636, 4956.727379994135, 5330.173823057432, 5461.290032295776, 5551.389347171888, 6315.684215789101, 6121.602095863755, 6130.398136742091, 6250.718717657807, 6262.968685156545, 6270.843228919313, 6101.7559297627595, 6151.231096112986, 6167.6916154193, 6186.659733714509, 6273.498120150468, 5342.492463215988, 5702.486776190163, 5952.494038006818, 5964.284285885721, 6192.752289908353, 5132.692038477703, 6182.28903676083, 6214.316425193316, 6215.595986260879, 6261.24865016201, 4983.775730092082, 6131.938680613137, 6159.507239420746, 6169.537284703755, 6179.536534760001], "unit": "score", "name": "dojo.html", "value": 5718.0515882112795}, {"lowerIsBetter": false, "replicates": [440.2361902099858, 528.873070463089, 549.6592112890007, 606.7087797857027, 607.0378450156508, 25729.87135064327, 37860.43209351855, 37978.430323545166, 38037.23925521488, 38062.42906356407, 39267.80366098173, 39286.21427571447, 39719.0, 39721.404178937264, 39721.808345749676, 9222.26221902248, 9406.905930940671, 9462.858057129148, 9470.242380609534, 9500.71497855062, 9420.952895235549, 9646.42121472714, 9681.661141860037, 9692.75768105796, 9692.806143877118, 9625.422474651508, 9681.903180968171, 9698.563564639608, 9729.562169702345, 9747.0, 9607.4715890626, 9671.371360861556, 9706.320557560974, 9726.854097188478, 9729.075737804897, 9470.810583788285, 9542.188913942324, 9566.90433095674, 9571.090746379083, 9574.186194173504, 37981.43027854584, 38145.42781858274, 38212.61787382118, 38362.61637383619, 38496.80751596252, 2788.247173263228, 2808.396194818124, 3057.327387974642, 3233.401820663185, 3390.627031026585, 26883.924643014256, 27206.911723531233, 27334.45331093387, 27392.315192120157, 27401.0, 2764.267469120685, 2778.2220978126156, 2804.1447358555633, 2971.7919745617814, 2984.3732816108645, 377118.0, 379774.10112949536, 381182.0, 381758.0, 381926.0, 56219.718901405235, 65045.34954650393, 65715.34284657188, 65766.0, 65879.34120658733, 62096.68951655213, 62968.37031629625, 63220.0, 63472.36527634757, 63740.0, 15404.845951540565, 15429.45996890126, 15467.767983480257, 15545.84454155444, 15607.297671604805, 12179.939100304442, 12485.87514124847, 12510.999120070555, 12546.05904557162, 12562.309073001074, 19657.01714914277, 20573.279935202198, 20580.691289630668, 20592.58814823695, 20683.58632827335, 8802.295816334678, 8988.0, 9010.414323068979, 9020.639174432948, 9104.8634270486, 879.9692010779592, 959.3572306554626, 998.311165295958, 1083.7019819549687, 1096.2545469081101, 23743.762562374155, 29467.85266073656, 29488.530517862382, 30182.84908575443, 30594.69405305963, 1002.7392877851811, 1044.8693913260843, 1173.8063219568846, 1176.894079532829, 1222.419350808359, 15037.172955487553, 15143.848561514244, 15320.354964498736, 15369.846301537065, 15405.460808871636, 537472.0, 543557.0, 544794.0, 547353.0, 550221.0, 58031.0, 58342.833143336895, 58367.70816145892, 58427.0, 58478.83042339129, 1414.0667159674772, 1424.608232736006, 1457.4680241711699, 1468.3612628506635, 1476.6677497563178, 26729.0, 29684.40631187321, 30361.848190758905, 30664.0, 30890.53664195084, 50451.49548504468, 50607.49392506028, 50937.981240375724, 51083.74458127686, 51239.97520049653, 378904.0, 379025.0, 380301.0, 380379.0, 380788.0, 28433.43133137284, 30738.692613074476, 30905.227369315948, 30980.380392392475, 31080.533791992686, 43615.0, 44761.0, 45177.54822451733, 45340.86647833831, 46176.30735538902, 34647.4802877952, 35107.12232194216, 35506.0, 35819.82090089533, 35897.820510897276, 30022.84988575043, 34978.65021349754, 36061.37723802383, 36516.452253216754, 36694.44958325681, 33641.99074027783, 33745.3250934975, 34707.0, 34854.651453486156, 34860.30279394449, 30826.845865770527, 31172.844135779174, 31281.687183128786, 31282.53076203904, 31480.37039259156, 20246.0, 22355.32934011982, 23950.760492394853, 24086.916088775695, 24553.63169552494], "unit": "score", "name": "ext.html", "value": 19232.651648293446}, {"lowerIsBetter": false, "replicates": [325.27139208173685, 349.6975116524206, 365.6946449714489, 366.5747732630148, 369.4329204670831, 15546.22268886554, 15570.844291557081, 19544.31594894179, 19942.800571994274, 20874.165033398665, 19289.13198906049, 19568.412947611596, 19635.920024398652, 19752.0, 19819.60360792783, 5583.776648934048, 5766.826995190151, 5807.912881306784, 5828.9417105828825, 5836.533077353823, 5511.889762204753, 5701.57238207134, 5760.135979603051, 5768.3654797972185, 5771.653700777946, 3872.1674839909556, 5562.637153897301, 5697.74360153792, 5837.270341207349, 5841.094630332305, 5800.651960882339, 5839.649621022752, 5859.707014649251, 5865.794697185578, 5889.381614930435, 5388.110961691316, 5596.300462442195, 5619.915701264485, 5624.072028115397, 5666.631668941505, 13085.214887106804, 15750.44873429436, 19161.520961975923, 23459.296221113393, 24159.87920060406, 2150.9139634414605, 2336.8013718833918, 2550.5154020736, 2717.836929784219, 2774.1677496751095, 9678.951605241999, 9994.0, 10675.78648427035, 12088.0, 13783.241921694304, 1528.7019031288903, 1739.6955532781712, 1768.1601239411305, 1789.2395731814056, 1804.2422182683304, 98393.0, 99542.0, 100604.99395006029, 101411.98588014173, 102309.0, 8997.01032886382, 10993.725156870982, 11213.271137376045, 11243.94378028121, 11317.0, 12740.617781466572, 13180.472781088649, 13374.799378009338, 13424.194548326936, 13455.0, 7013.684384202723, 8267.049289331684, 8431.831363372821, 8486.872696909551, 8525.786855328543, 8597.398182127192, 8634.352423568258, 8645.135486451305, 8649.654013839376, 8655.52394618302, 4368.825246990148, 4431.734095954189, 4437.600615944516, 4454.086912182995, 4542.68201225911, 1588.3408385519879, 1875.493616723477, 1890.0927554773787, 1892.536328599502, 1926.3931861463593, 407.7023772645985, 416.4897999950098, 420.6487582868278, 442.75302838096786, 458.159277725371, 11251.83122253167, 11955.40222988847, 12003.339816310187, 12030.759384812254, 19697.606047878962, 711.8256027273247, 760.3574979142616, 835.4360806455618, 897.4794619120894, 947.3652652722692, 9063.68277110298, 10264.640737574298, 10727.249092563601, 10754.139668826476, 10768.3538987661, 385283.0, 501216.0, 616941.0, 730682.0, 750948.0, 101382.0, 102366.0, 118525.0, 118537.40731296288, 122836.0, 1177.270092542629, 1198.161287099034, 1198.5325722968223, 1224.2715584227549, 1236.202649291202, 18357.3574924877, 18605.534861628566, 18643.161057752164, 18711.88872504113, 18997.715034274774, 49120.75439622779, 50107.24839127343, 50523.0, 51177.0, 51252.74373628108, 70256.94614580683, 71346.07596582238, 72857.0, 73128.0, 73146.0, 7421.591812450151, 7638.15980242184, 7640.465167438226, 7646.847063058819, 7682.193369696325, 10328.535215915152, 10736.83894741564, 11544.249623774427, 11848.822267666164, 11864.288142711119, 7869.763907082796, 7921.762347129596, 9217.124373184537, 10433.008864157893, 10643.04212620837, 9957.551910163915, 10301.690949271533, 10338.586456541654, 10350.430726310125, 10534.736631584272, 9477.715668529956, 10876.945615271872, 10960.530911630965, 10986.862023953005, 11107.777844443228, 7071.504994650325, 7312.268773122645, 7330.824271454702, 7388.852222955618, 7423.92576074254, 8635.784105397415, 8988.955055224682, 10462.686119416125, 10568.207384446043, 10726.302790318605], "unit": "score", "name": "jquery.html", "value": 8789.166363202527}, {"lowerIsBetter": false, "replicates": [1510.410939733504, 1531.640064584822, 1747.2748809244165, 1850.2968871828703, 1862.3761040051575, 7788.883166752503, 8465.322774178067, 8620.913790862089, 8829.42608730432, 8839.425437346576, 8528.317734581235, 8558.400911936167, 8651.69719059833, 8709.695160669362, 8724.781880452976, 2445.6942882139733, 2466.3094333586623, 2467.3091534370405, 2479.776820086192, 2485.7887079598254, 2426.0538390027905, 2477.1949116537107, 2479.417336925821, 2493.0775613023206, 2499.4376265340334, 2160.8811515366647, 2403.471236328005, 2442.7312995570474, 2442.864068208283, 2461.9753802462014, 2401.7117945846435, 2413.227767114524, 2451.350392146083, 2464.6426268191103, 2468.5309791139716, 2431.3921519620094, 2447.4248551590363, 2450.6691596634405, 2452.7424620414777, 2455.594826853567, 8519.48883067018, 8580.013298470692, 8590.828183436297, 8607.784805379853, 8627.956860215721, 5246.108161612497, 5442.210879422501, 5474.206240095204, 5477.835664930059, 5480.04099282628, 3739.0278527582755, 3747.7563958342894, 3753.39945608704, 3766.868159614428, 3777.301199278142, 920.9631614735403, 963.0754475703333, 1023.4626820919077, 1060.6234786650705, 1105.4969988655143, 11055.889441105566, 11634.185607007514, 11745.706357341049, 11747.236429632132, 11875.34685592292, 4059.837606495766, 4839.871798057066, 4918.1393256180745, 4969.875753106201, 4982.427020892571, 10124.341917775468, 10182.541785619665, 10228.284020118668, 10236.948815255875, 10248.692539223835, 5454.645448045943, 5468.425815289417, 5495.543680924558, 5496.697681627469, 5504.889902201933, 4924.089043526959, 4943.950560494421, 4950.2079667253065, 4950.282209079735, 4965.4289756678445, 3971.0667993021616, 3973.1854969731135, 4008.1382502762044, 4021.8190181441905, 4029.9597004029583, 1217.415640492551, 1303.2571434282559, 1306.6472052545948, 1310.423413697989, 1334.3928512526777, 1062.6440142552176, 1064.2497039587072, 1095.742500512379, 1206.7043574324346, 1327.2169420042221, 7844.137144914055, 7879.921200788033, 7934.682612695427, 7967.3626109911065, 8053.959730201312, 999.8300288950895, 1152.7752088342693, 1155.2259985809528, 1159.7042754097652, 1170.6839153428527, 6152.323244443108, 6185.628862268189, 6205.596636218631, 6208.72060757267, 6310.0534919761485, 10009.949950250202, 10542.841857372145, 10602.787944241072, 10642.988916052962, 10663.146948244123, 10318.226133039901, 10481.685549433529, 10485.423301718327, 10554.577816887391, 10555.947220264003, 8177.591120443954, 8196.42625016255, 8252.793680157924, 8278.254957053894, 8295.7971094191, 7672.232776722283, 7794.596972544997, 7810.0, 7831.96084019599, 7839.608019599112, 9266.768330791785, 9428.10433008863, 9456.763580910532, 9498.09768072032, 9581.185599224144, 9627.614895404105, 9899.059589339002, 9913.157381622643, 9919.15687166599, 9956.402615843073, 7365.52124111931, 7392.371648409945, 7418.072740907387, 7460.962695186489, 7462.552246865205, 6751.729930802713, 8040.316573091352, 8122.187781221831, 8131.349492040505, 8134.10524842255, 5839.299284085937, 7637.0, 7681.1934746850775, 7807.687692492464, 7835.804104897195, 6006.549508786946, 6263.96868015657, 7266.491345605757, 7395.149557800922, 7481.326680598772, 7321.707131714672, 7477.813054673677, 7506.28690274423, 7506.474546781673, 7545.396368290633, 5783.595148339576, 6854.34883686049, 6864.759733409307, 6876.896846547406, 6953.79138625842, 6768.0863083485065, 6830.419414349836, 6976.511644184859, 6988.231294557696, 7001.684924178526], "unit": "score", "name": "mootools.html", "value": 4889.927040858282}, {"lowerIsBetter": false, "replicates": [328.16973058162847, 332.3005074318559, 336.28371568558964, 339.1639608365379, 344.38871003967967, 5637.238972738689, 6836.658167091638, 7049.3655570998535, 7052.753153639624, 7087.716491340347, 7007.544509606884, 7037.3666370026685, 7066.540674856144, 7117.501774875748, 7120.893186602192, 5196.29849970253, 5197.896042079156, 5202.089634313989, 5213.86965325868, 5215.40022897366, 4809.951900480985, 5214.400343960455, 5214.817481388152, 5216.6869987800665, 5223.555997740177, 4889.755512224392, 4895.975520122394, 4897.142999975008, 4908.901821963558, 4923.163062279403, 4061.35018397058, 4884.047610715894, 4886.1204983103025, 4904.852854414374, 4912.7297998610065, 4208.705390622657, 4225.514065882432, 4225.964638663547, 4234.195502854448, 4237.152569486115, 6591.505637077191, 6725.428338591226, 6727.461803055793, 6728.865422691568, 6739.157605299338, 5980.760769569256, 5980.820575382745, 5984.251968503937, 6001.459868611802, 6001.609895356788, 7541.886871696929, 7545.170031296553, 7548.5848278344665, 7553.546787192786, 7562.546247225184, 3837.76973381598, 4061.5938406159444, 4539.500654927955, 4657.091867085919, 4758.2386818108935, 6473.870522589569, 7724.961375193088, 8017.158198389144, 8035.839283214303, 8039.0, 4393.011572396185, 4528.320751887178, 4848.587870031087, 4857.854264372075, 4858.271259311132, 4036.717429779946, 4754.429468463806, 4942.703437793743, 4953.157963146274, 4964.726940018261, 4778.283257511332, 4926.162552366106, 5940.910886336708, 6002.339742628307, 6013.759449622054, 6315.526335524854, 7534.397248220129, 7534.510256833289, 7606.885896711554, 7614.2766437188375, 1700.766943965615, 1722.7596130785814, 1724.4998950304523, 1733.5406117378905, 1733.6966030944534, 878.4377998081233, 1091.1380009792333, 1095.6603452929617, 1099.054812860939, 1108.6286094158386, 6677.732890684319, 6988.930110698828, 6995.93004069963, 7032.929670703227, 7033.613151276729, 6708.765193218214, 7313.0, 7792.922070779219, 7834.921650783534, 7843.098043724931, 6016.548758843104, 6560.867717991672, 6947.7220911163995, 6957.686904089328, 6963.408110310579, 3373.9662603374145, 4141.772202528829, 4146.979265103655, 4153.397757325171, 4160.521540022875, 8051.597420129087, 8147.185281471924, 8149.79625509367, 8161.469504482189, 8164.387670924704, 7863.515935478848, 7990.280874721303, 8024.638891249908, 8044.0, 8083.83832323362, 8106.108328084024, 8125.268725814587, 8129.268365847102, 8139.593020348959, 8165.2243036911395, 7611.923880761343, 7799.337056350274, 7805.18045605226, 7833.882491762742, 7987.520748755093, 6340.9048864268, 7718.807029824075, 7733.0, 7739.535627862347, 7770.45606807518, 6053.848653783691, 8241.98071472493, 8256.174382561696, 8278.048024477263, 8316.958415207886, 4873.512648735098, 4890.388701412324, 4902.338184345068, 4906.092372911023, 4908.386451693538, 6548.47612191014, 6779.966100169468, 7756.0304961879765, 7885.2114788520685, 7909.7231596893835, 6208.844778880564, 7404.777856664308, 7578.431617628589, 7594.278543538355, 7687.846243074995, 6467.353264673495, 7553.924460755322, 7566.508176968479, 7577.848443030998, 7586.696532138652, 6599.878020736583, 6907.481938854506, 7385.778426647209, 7427.183009868802, 7455.0, 7329.890051649123, 7586.468947173645, 7606.8098297543, 7616.923830761843, 7693.961530192313, 7416.25837416254, 7425.7029718810645, 7428.665710042953, 7439.0, 7443.25567443273], "unit": "score", "name": "prototype.html", "value": 5363.9851931819785}, {"lowerIsBetter": false, "replicates": [682.6006786030172, 713.0908092182467, 715.1406343506886, 738.3686947659751, 739.5562662402557, 14728.337224824882, 14773.261336933165, 14828.258587070644, 14848.406063757437, 14859.554213373602, 13543.525976590821, 13763.518276860286, 13902.026858119936, 13914.721705565908, 13915.930420347884, 677.082553140495, 847.4110493207239, 851.5699571716275, 851.5954921412341, 869.5347988825979, 859.5702148925537, 869.3697069624503, 871.8256348730248, 871.8561437362828, 876.701921346742, 892.8214357128568, 903.9005709371963, 905.5155491811882, 905.9728208153733, 911.5806728904679, 887.1173182683207, 889.3774357949461, 895.5566994337845, 901.0088902207585, 902.5757893789909, 652.5301782716436, 662.8707402056552, 668.1547841979899, 672.4855485553555, 674.6120980436219, 14521.419143234363, 14638.560843174615, 14695.338709758087, 14749.705005899821, 14816.481423150246, 12697.746045079139, 12736.745265094647, 12740.108192426535, 12893.67765805853, 13261.933690331487, 10002.899971000343, 10143.25588827136, 10459.110975567086, 10559.841602375971, 10878.510467029002, 3988.900277493086, 4040.1313717550574, 4042.0, 4099.795010249505, 4117.238310912461, 80082.0, 80240.59879700623, 81068.59465702693, 81214.59392703058, 81319.18680813235, 7506.887396689054, 9259.72220833376, 9278.907210927939, 9391.248700103975, 9701.0, 20549.0, 20559.588808224053, 20757.0, 20826.583468330547, 20869.478263043544, 7606.847863042708, 7685.730999414994, 7719.189485103983, 7800.835661532102, 7877.172896845863, 4074.5110586729784, 4079.592040795956, 4155.958440415558, 4255.446791917093, 4267.1892340455215, 3364.091695242271, 3384.221629025338, 3385.864565417405, 3408.079818449005, 3412.351653185887, 639.9616023038633, 642.7975187815823, 647.4787795824312, 672.3612568060264, 672.8856094463953, 537.1888448442879, 581.9156222347821, 586.3930831589284, 588.399832171183, 619.7118339971935, 8310.085890552034, 8511.148885111439, 8688.782780430414, 8721.825563488695, 8767.956160219286, 559.6166625861217, 599.3317451042057, 606.6208619612742, 612.5620181570199, 626.3485974586379, 3922.2547715933883, 3959.7228194026143, 4001.7198796083994, 4102.5692302307825, 4409.0520538084465, 77372.61313693508, 89076.5546172265, 90489.0, 99885.50057249668, 100552.99447005583, 64008.67995659992, 64470.06589802313, 67319.0, 76600.0, 78903.02742431485, 51243.97512049738, 51336.48663513317, 69220.65389673019, 69382.9592556112, 70557.0, 8808.867866981873, 8828.470291782256, 8865.734027979172, 8960.19013666057, 9017.2786177107, 41574.0, 49019.26471102865, 49390.27134050291, 49566.75216624038, 49871.0, 67237.66381168063, 70042.29957700561, 70193.64903175451, 70451.29548704447, 70799.0, 10782.353058816496, 10790.082842958436, 10850.29473084247, 11171.329720216812, 11807.940960295144, 11954.342511161969, 12064.396780160781, 12229.388530573258, 12325.01399887989, 12638.178518396275, 11151.386673733023, 11276.097912167172, 11391.088712903114, 11550.884491155317, 11694.88305116972, 11512.712182195177, 11788.29270243788, 11822.527098916291, 11830.526778928746, 11852.0, 10757.085647720032, 11268.549258029914, 11502.712432189262, 11526.0, 12306.75386492283, 9249.167574918021, 9307.395019323721, 9365.672201472917, 9686.273529485175, 9951.452670102924, 9012.684556040507, 9028.277737781093, 9230.261579073524, 9406.670766523139, 9824.852627210455], "unit": "score", "name": "yui.html", "value": 6866.851834823643}], "name": "dromaeo_css", "value": 7472.555213042612}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [111.0, 107.0, 97.0, 143.0, 106.0, 169.0, 167.0, 167.0, 114.0, 113.0], "unit": "score", "name": "ai-astar", "value": 129.4}, {"lowerIsBetter": true, "replicates": [161.0, 119.0, 149.0, 152.0, 125.0, 140.0, 156.0, 155.0, 162.0, 137.0], "unit": "score", "name": "audio-beat-detection", "value": 145.6}, {"lowerIsBetter": true, "replicates": [193.0, 229.0, 273.0, 222.0, 198.0, 200.0, 198.0, 198.0, 234.0, 277.0], "unit": "score", "name": "audio-dft", "value": 222.2}, {"lowerIsBetter": true, "replicates": [70.0, 74.0, 71.0, 122.0, 59.0, 83.0, 84.0, 74.0, 67.0, 54.0], "unit": "score", "name": "audio-fft", "value": 75.8}, {"lowerIsBetter": true, "replicates": [82.0, 91.0, 144.0, 116.0, 84.0, 81.0, 116.0, 108.0, 74.0, 104.0], "unit": "score", "name": "audio-oscillator", "value": 100.0}, {"lowerIsBetter": true, "replicates": [87.0, 94.0, 86.0, 94.0, 87.0, 93.0, 87.0, 94.0, 87.0, 93.0], "unit": "score", "name": "imaging-gaussian-blur", "value": 90.2}, {"lowerIsBetter": true, "replicates": [154.0, 153.0, 97.0, 97.0, 95.0, 95.0, 96.0, 95.0, 97.0, 98.0], "unit": "score", "name": "imaging-darkroom", "value": 107.7}, {"lowerIsBetter": true, "replicates": [91.0, 93.0, 100.0, 137.0, 94.0, 89.0, 95.0, 92.0, 91.0, 90.0], "unit": "score", "name": "imaging-desaturate", "value": 97.2}, {"lowerIsBetter": true, "replicates": [58.0, 59.0, 56.0, 57.0, 60.0, 57.0, 58.0, 67.0, 57.0, 57.0], "unit": "score", "name": "json-parse-financial", "value": 58.6}, {"lowerIsBetter": true, "replicates": [69.0, 75.0, 64.0, 73.0, 70.0, 67.0, 64.0, 67.0, 67.0, 68.0], "unit": "score", "name": "json-stringify-tinderbox", "value": 68.4}, {"lowerIsBetter": true, "replicates": [98.0, 112.0, 116.0, 84.0, 85.0, 84.0, 86.0, 86.0, 84.0, 87.0], "unit": "score", "name": "stanford-crypto-aes", "value": 92.2}, {"lowerIsBetter": true, "replicates": [126.0, 130.0, 128.0, 123.0, 122.0, 127.0, 128.0, 138.0, 125.0, 125.0], "unit": "score", "name": "stanford-crypto-ccm", "value": 127.2}, {"lowerIsBetter": true, "replicates": [138.0, 145.0, 142.0, 144.0, 172.0, 186.0, 184.0, 155.0, 140.0, 140.0], "unit": "score", "name": "stanford-crypto-pbkdf2", "value": 154.6}, {"lowerIsBetter": true, "replicates": [66.0, 71.0, 68.0, 97.0, 99.0, 98.0, 105.0, 78.0, 61.0, 95.0], "unit": "score", "name": "stanford-crypto-sha256-iterative", "value": 83.8}], "name": "kraken", "value": 1552.9}]} 10:08:11 INFO - TinderboxPrint: TalosResult: {"graphserver": {"kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1552.90"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7472.56"}}} 10:08:11 INFO - Return code: 0 10:08:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 10:08:11 INFO - # TBPL SUCCESS # 10:08:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 10:08:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 10:08:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 10:08:11 INFO - 2016-02-08 10:08:11.338 screenresolution[1985:14776] starting screenresolution argv=screenresolution get 10:08:11 INFO - 2016-02-08 10:08:11.340 screenresolution[1985:14776] Display 0: 1600x1200x32@60 10:08:11 INFO - 2016-02-08 10:08:11.346 screenresolution[1986:14779] starting screenresolution argv=screenresolution list 10:08:11 INFO - Available Modes on Display 0 10:08:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 10:08:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 10:08:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 10:08:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 10:08:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 10:08:11 INFO - Intel Iris: 10:08:11 INFO - Chipset Model: Intel Iris 10:08:11 INFO - Type: GPU 10:08:11 INFO - Bus: Built-In 10:08:11 INFO - VRAM (Dynamic, Max): 1536 MB 10:08:11 INFO - Vendor: Intel (0x8086) 10:08:11 INFO - Device ID: 0x0a2e 10:08:11 INFO - Revision ID: 0x0009 10:08:11 INFO - Displays: 10:08:11 INFO - Display: 10:08:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 10:08:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 10:08:11 INFO - Display Serial Number: 1600x1200 60 10:08:11 INFO - Main Display: Yes 10:08:11 INFO - Mirror: Off 10:08:11 INFO - Online: Yes 10:08:11 INFO - Rotation: Supported 10:08:11 INFO - Return code: 0 10:08:11 INFO - Running post-action listener: _resource_record_post_action 10:08:11 INFO - Running post-run listener: _resource_record_post_run 10:08:12 INFO - Total resource usage - Wall time: 1206s; CPU: 54.0%; Read bytes: 2383872; Write bytes: 712667648; Read time: 34; Write time: 1932 10:08:12 INFO - install - Wall time: 35s; CPU: 55.0%; Read bytes: 390982144; Write bytes: 384978432; Read time: 29565; Write time: 691 10:08:12 INFO - run-tests - Wall time: 1173s; CPU: 53.0%; Read bytes: 2383872; Write bytes: 303371264; Read time: 34; Write time: 1187 10:08:12 INFO - Running post-run listener: _upload_blobber_files 10:08:12 INFO - Blob upload gear active. 10:08:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 10:08:12 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:08:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Fx-Team', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 10:08:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Fx-Team -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 10:08:13 INFO - (blobuploader) - INFO - Open directory for files ... 10:08:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 10:08:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 10:08:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:14 INFO - (blobuploader) - INFO - Done attempting. 10:08:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 10:08:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 10:08:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 10:08:15 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 10:08:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 10:08:15 INFO - (blobuploader) - INFO - Done attempting. 10:08:15 INFO - (blobuploader) - INFO - Iteration through files over. 10:08:15 INFO - Return code: 0 10:08:15 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 10:08:15 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 10:08:15 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab8d6524148d92b0ce7ce59a1345f754e8c1588d191604540040cc6c8c271f11ff49bd6ab618f97f7073b2d766b2104ac5fc8a5b19f788fc7146d64beee7c383", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ab8b139a26b0c8a81696e132a7778d44303c2dc1219bf9b2b7dd5a01dc3b718c15e73ead4b6619deece1126586d18f0b15209369cf4b0f31820adf15a6cb379"} 10:08:15 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 10:08:15 INFO - Writing to file /builds/slave/test/properties/blobber_files 10:08:15 INFO - Contents: 10:08:15 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab8d6524148d92b0ce7ce59a1345f754e8c1588d191604540040cc6c8c271f11ff49bd6ab618f97f7073b2d766b2104ac5fc8a5b19f788fc7146d64beee7c383", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ab8b139a26b0c8a81696e132a7778d44303c2dc1219bf9b2b7dd5a01dc3b718c15e73ead4b6619deece1126586d18f0b15209369cf4b0f31820adf15a6cb379"} 10:08:15 INFO - Running post-run listener: copy_logs_to_upload_dir 10:08:15 INFO - Copying logs to upload dir... 10:08:15 INFO - mkdir: /builds/slave/test/build/upload/logs 10:08:15 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.975565 ========= master_lag: 0.00 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2016-02-08 10:08:15.646339) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-08 10:08:15.654254) ========= 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.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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/Fx-Team/sha512/ab8d6524148d92b0ce7ce59a1345f754e8c1588d191604540040cc6c8c271f11ff49bd6ab618f97f7073b2d766b2104ac5fc8a5b19f788fc7146d64beee7c383", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ab8b139a26b0c8a81696e132a7778d44303c2dc1219bf9b2b7dd5a01dc3b718c15e73ead4b6619deece1126586d18f0b15209369cf4b0f31820adf15a6cb379"} build_url:https://queue.taskcluster.net/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011071 build_url: 'https://queue.taskcluster.net/v1/task/B-xOeHQORRiffk3EvVWfyg/artifacts/public/build/firefox-47.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/ab8d6524148d92b0ce7ce59a1345f754e8c1588d191604540040cc6c8c271f11ff49bd6ab618f97f7073b2d766b2104ac5fc8a5b19f788fc7146d64beee7c383", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Fx-Team/sha512/3ab8b139a26b0c8a81696e132a7778d44303c2dc1219bf9b2b7dd5a01dc3b718c15e73ead4b6619deece1126586d18f0b15209369cf4b0f31820adf15a6cb379"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2016-02-08 10:08:15.684705) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 10:08:15.685058) ========= 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.H3J6fzx4wd/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.ZJVXjK6mAh/Listeners TMPDIR=/var/folders/2x/nv87v62s4vz7ppmnpm2v5q4000000w/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.005013 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-02-08 10:08:15.734605) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 10:08:15.737997) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-02-08 10:08:15.738375) ========= ========= Total master_lag: 0.27 =========