builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0015 starttime: 1448064975.38 results: success (0) buildid: 20151120132233 builduid: ae92f4d77e6b4fcc806d374a4fb8c0d7 revision: b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:15.382234) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:15.382684) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:15.382971) ========= 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.EnkqetoiUA/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.Eij1VI7zXq/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.005585 basedir: '/builds/slave/test' ========= master_lag: 0.01 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:15.402863) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:15.403164) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:15.417278) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:15.417631) ========= 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.EnkqetoiUA/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.Eij1VI7zXq/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.005292 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:15.466399) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:15.466758) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:15.467116) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:15.467403) ========= 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.EnkqetoiUA/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.Eij1VI7zXq/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 --2015-11-20 16:16:15-- 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.29M=0.001s 2015-11-20 16:16:15 (8.29 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.217267 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:15.698633) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:15.698977) ========= 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.EnkqetoiUA/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.Eij1VI7zXq/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.019230 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:15.747405) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 16:16:15.747779) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73 --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 b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.EnkqetoiUA/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.Eij1VI7zXq/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 2015-11-20 16:16:15,824 truncating revision to first 12 chars 2015-11-20 16:16:15,824 Setting DEBUG logging. 2015-11-20 16:16:15,824 attempt 1/10 2015-11-20 16:16:15,824 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/b0bdf1bc3b61?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-20 16:16:16,898 unpacking tar archive at: fx-team-b0bdf1bc3b61/testing/mozharness/ program finished with exit code 0 elapsedTime=1.312144 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-20 16:16:17.074126) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:17.074461) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:17.085279) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:17.085603) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-20 16:16:17.086021) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-20 16:16:17.086323) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --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', '--system-bits', '64', '--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.EnkqetoiUA/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.Eij1VI7zXq/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 16:16:17 INFO - MultiFileLogger online at 20151120 16:16:17 in /builds/slave/test 16:16:17 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 16:16:17 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 16:16:17 INFO - {'append_to_log': False, 16:16:17 INFO - 'base_work_dir': '/builds/slave/test', 16:16:17 INFO - 'blob_upload_branch': 'Fx-Team', 16:16:17 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 16:16:17 INFO - 'branch': 'Fx-Team', 16:16:17 INFO - 'buildbot_json_path': 'buildprops.json', 16:16:17 INFO - 'config_files': ('talos/mac_config.py',), 16:16:17 INFO - 'default_actions': ('clobber', 16:16:17 INFO - 'read-buildbot-config', 16:16:17 INFO - 'download-and-extract', 16:16:17 INFO - 'populate-webroot', 16:16:17 INFO - 'create-virtualenv', 16:16:17 INFO - 'install', 16:16:17 INFO - 'run-tests'), 16:16:17 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 16:16:17 INFO - 'download_minidump_stackwalk': True, 16:16:17 INFO - 'download_symbols': 'ondemand', 16:16:17 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 16:16:17 INFO - 'tooltool.py': '/tools/tooltool.py', 16:16:17 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 16:16:17 INFO - '/tools/misc-python/virtualenv.py')}, 16:16:17 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 16:16:17 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 16:16:17 INFO - 'installer_path': 'installer.exe', 16:16:17 INFO - 'log_level': 'info', 16:16:17 INFO - 'log_name': 'talos', 16:16:17 INFO - 'log_to_console': True, 16:16:17 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 16:16:17 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 16:16:17 INFO - 'opt_config_files': (), 16:16:17 INFO - 'pip_index': False, 16:16:17 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:16:17 INFO - 'cmd': ('bash', 16:16:17 INFO - '-c', 16:16:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:16:17 INFO - 'enabled': True, 16:16:17 INFO - 'halt_on_failure': False, 16:16:17 INFO - 'name': 'check_screen_resolution'},), 16:16:17 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 16:16:17 INFO - 'cmd': ('bash', 16:16:17 INFO - '-c', 16:16:17 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 16:16:17 INFO - 'enabled': True, 16:16:17 INFO - 'halt_on_failure': False, 16:16:17 INFO - 'name': 'check_screen_resolution'},), 16:16:17 INFO - 'run_cmd_checks_enabled': True, 16:16:17 INFO - 'sps_profile': False, 16:16:17 INFO - 'sps_profile_interval': 0, 16:16:17 INFO - 'suite': 'dromaeojs-e10s', 16:16:17 INFO - 'system_bits': '64', 16:16:17 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 16:16:17 INFO - 'title': 't-yosemite-r7-0015', 16:16:17 INFO - 'tooltool_cache': '/builds/tooltool_cache', 16:16:17 INFO - 'use_talos_json': True, 16:16:17 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 16:16:17 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 16:16:17 INFO - 'work_dir': 'build'} 16:16:17 INFO - ##### 16:16:17 INFO - ##### Running clobber step. 16:16:17 INFO - ##### 16:16:17 INFO - Running pre-action listener: _resource_record_pre_action 16:16:17 INFO - Running main action method: clobber 16:16:17 INFO - rmtree: /builds/slave/test/build 16:16:17 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 16:16:18 INFO - Running post-action listener: _resource_record_post_action 16:16:18 INFO - ##### 16:16:18 INFO - ##### Running read-buildbot-config step. 16:16:18 INFO - ##### 16:16:18 INFO - Running pre-action listener: _resource_record_pre_action 16:16:18 INFO - Running main action method: read_buildbot_config 16:16:18 INFO - Using buildbot properties: 16:16:18 INFO - { 16:16:18 INFO - "properties": { 16:16:18 INFO - "buildnumber": 13, 16:16:18 INFO - "product": "firefox", 16:16:18 INFO - "script_repo_revision": "production", 16:16:18 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 16:16:18 INFO - "repository": "", 16:16:18 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 16:16:18 INFO - "buildid": "20151120132233", 16:16:18 INFO - "slavename": "t-yosemite-r7-0015", 16:16:18 INFO - "pgo_build": "False", 16:16:18 INFO - "basedir": "/builds/slave/test", 16:16:18 INFO - "project": "", 16:16:18 INFO - "platform": "yosemite_r7", 16:16:18 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 16:16:18 INFO - "slavebuilddir": "test", 16:16:18 INFO - "scheduler": "tests-fx-team-macosx64-talos", 16:16:18 INFO - "branch": "fx-team", 16:16:18 INFO - "repo_path": "integration/fx-team", 16:16:18 INFO - "stage_platform": "macosx64", 16:16:18 INFO - "builduid": "ae92f4d77e6b4fcc806d374a4fb8c0d7", 16:16:18 INFO - "revision": "b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73" 16:16:18 INFO - }, 16:16:18 INFO - "sourcestamp": { 16:16:18 INFO - "repository": "", 16:16:18 INFO - "hasPatch": false, 16:16:18 INFO - "project": "", 16:16:18 INFO - "branch": "fx-team-macosx64-talos", 16:16:18 INFO - "changes": [ 16:16:18 INFO - { 16:16:18 INFO - "category": null, 16:16:18 INFO - "files": [ 16:16:18 INFO - { 16:16:18 INFO - "url": null, 16:16:18 INFO - "name": "https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 16:16:18 INFO - } 16:16:18 INFO - ], 16:16:18 INFO - "repository": "", 16:16:18 INFO - "rev": "b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73", 16:16:18 INFO - "who": "bgrinstead@mozilla.com", 16:16:18 INFO - "when": 1448060873, 16:16:18 INFO - "number": 6690915, 16:16:18 INFO - "comments": "Bug 1201962 - Enable service worker logging in web console by default;r=ejpbruel", 16:16:18 INFO - "project": "", 16:16:18 INFO - "at": "Fri 20 Nov 2015 15:07:53", 16:16:18 INFO - "branch": "fx-team-macosx64-talos", 16:16:18 INFO - "revlink": "", 16:16:18 INFO - "properties": [ 16:16:18 INFO - [ 16:16:18 INFO - "buildid", 16:16:18 INFO - "20151120132233", 16:16:18 INFO - "Change" 16:16:18 INFO - ], 16:16:18 INFO - [ 16:16:18 INFO - "builduid", 16:16:18 INFO - "ae92f4d77e6b4fcc806d374a4fb8c0d7", 16:16:18 INFO - "Change" 16:16:18 INFO - ], 16:16:18 INFO - [ 16:16:18 INFO - "pgo_build", 16:16:18 INFO - "False", 16:16:18 INFO - "Change" 16:16:18 INFO - ] 16:16:18 INFO - ], 16:16:18 INFO - "revision": "b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73" 16:16:18 INFO - } 16:16:18 INFO - ], 16:16:18 INFO - "revision": "b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73" 16:16:18 INFO - } 16:16:18 INFO - } 16:16:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 16:16:18 INFO - Running post-action listener: _resource_record_post_action 16:16:18 INFO - ##### 16:16:18 INFO - ##### Running download-and-extract step. 16:16:18 INFO - ##### 16:16:18 INFO - Running pre-action listener: _resource_record_pre_action 16:16:18 INFO - Running main action method: download_and_extract 16:16:18 INFO - mkdir: /builds/slave/test/build/tests 16:16: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')]} 16:16:18 INFO - https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 16:16:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/test_packages.json 16:16:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/test_packages.json 16:16:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 16:16:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 16:16:19 INFO - Downloaded 1149 bytes. 16:16:19 INFO - Reading from file /builds/slave/test/build/test_packages.json 16:16:19 INFO - Using the following test package requirements: 16:16:19 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:16:19 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:16:19 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 16:16:19 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:16:19 INFO - u'jsshell-mac.zip'], 16:16:19 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:16:19 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 16:16:19 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:16:19 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:16:19 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 16:16:19 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:16:19 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 16:16:19 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:16:19 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 16:16:19 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 16:16:19 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 16:16:19 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 16:16:19 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 16:16:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:19 INFO - https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:16:19 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:16:19 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:16:19 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:16:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:16:20 INFO - Downloaded 17526882 bytes. 16:16:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 16:16:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:16:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:16:23 INFO - Return code: 0 16:16:23 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 16:16: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')]} 16:16:23 INFO - https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 16:16:23 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:16:23 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:16:23 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:16:23 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 16:16:24 INFO - Downloaded 17526882 bytes. 16:16:24 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 16:16:24 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 16:16:24 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 16:16:27 INFO - Return code: 0 16:16:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:27 INFO - https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 16:16:27 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:16:27 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:16:27 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:16:27 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 16:16:28 INFO - Downloaded 11130997 bytes. 16:16:28 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 16:16:28 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 16:16:28 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 16:16:29 INFO - Return code: 0 16:16:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:29 INFO - https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 16:16:29 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:16:29 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:16:29 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 16:16:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 16:16:32 INFO - Downloaded 109418709 bytes. 16:16:32 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:16:32 INFO - mkdir: /builds/slave/test/properties 16:16:32 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 16:16:32 INFO - Writing to file /builds/slave/test/properties/build_url 16:16:32 INFO - Contents: 16:16:32 INFO - build_url:https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 16:16:32 INFO - Running post-action listener: _resource_record_post_action 16:16:32 INFO - Running post-action listener: set_extra_try_arguments 16:16:32 INFO - ##### 16:16:32 INFO - ##### Running populate-webroot step. 16:16:32 INFO - ##### 16:16:32 INFO - Running pre-action listener: _resource_record_pre_action 16:16:32 INFO - Running main action method: populate_webroot 16:16:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 16:16:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 16:16:32 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 16:16:32 INFO - '../fennec_ids.txt'], 16:16:32 INFO - 'tests': ['tcheck2']}, 16:16:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 16:16:32 INFO - '--tppagecycles', 16:16:32 INFO - '7'], 16:16:32 INFO - 'tests': ['tsvgm']}}, 16:16:32 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 16:16:32 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 16:16:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 16:16:32 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:16:32 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 16:16:32 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 16:16:32 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:16:32 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:32 INFO - 'talos_options': ['--e10s'], 16:16:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 16:16:32 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:32 INFO - 'tests': ['damp', 'tps']}, 16:16:32 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:32 INFO - 'talos_options': ['--e10s'], 16:16:32 INFO - 'tests': ['damp', 'tps']}, 16:16:32 INFO - 'g3': {'tests': ['dromaeo_dom']}, 16:16:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 16:16:32 INFO - 'other': {'tests': ['a11yr', 16:16:32 INFO - 'ts_paint', 16:16:32 INFO - 'tpaint', 16:16:32 INFO - 'sessionrestore', 16:16:32 INFO - 'sessionrestore_no_auto_restore']}, 16:16:32 INFO - 'other-e10s': {'talos_options': ['--e10s'], 16:16:32 INFO - 'tests': ['a11yr', 16:16:32 INFO - 'ts_paint', 16:16:32 INFO - 'tpaint', 16:16:32 INFO - 'sessionrestore', 16:16:32 INFO - 'sessionrestore_no_auto_restore']}, 16:16:32 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 16:16:32 INFO - 'tests': ['a11yr', 16:16:32 INFO - 'ts_paint', 16:16:32 INFO - 'tpaint', 16:16:32 INFO - 'sessionrestore', 16:16:32 INFO - 'sessionrestore_no_auto_restore']}, 16:16:32 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 16:16:32 INFO - 'tests': ['a11yr', 16:16:32 INFO - 'ts_paint', 16:16:32 INFO - 'tpaint', 16:16:32 INFO - 'sessionrestore', 16:16:32 INFO - 'sessionrestore_no_auto_restore']}, 16:16:32 INFO - 'other_l64': {'tests': ['a11yr', 16:16:32 INFO - 'ts_paint', 16:16:32 INFO - 'tpaint', 16:16:32 INFO - 'sessionrestore', 16:16:32 INFO - 'sessionrestore_no_auto_restore']}, 16:16:32 INFO - 'other_nol64': {'tests': ['a11yr', 16:16:32 INFO - 'ts_paint', 16:16:32 INFO - 'tpaint', 16:16:32 INFO - 'sessionrestore', 16:16:32 INFO - 'sessionrestore_no_auto_restore']}, 16:16:32 INFO - 'svgr': {'tests': ['tsvgx', 16:16:32 INFO - 'tsvgr_opacity', 16:16:32 INFO - 'tart', 16:16:32 INFO - 'tscrollx', 16:16:32 INFO - 'cart']}, 16:16:32 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 16:16:32 INFO - 'tests': ['tsvgx', 16:16:32 INFO - 'tsvgr_opacity', 16:16:32 INFO - 'tart', 16:16:32 INFO - 'tscrollx', 16:16:32 INFO - 'cart']}, 16:16:32 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:32 INFO - 'tests': ['tp5o']}, 16:16:32 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:32 INFO - 'talos_options': ['--e10s'], 16:16:32 INFO - 'tests': ['tp5o']}, 16:16:32 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:32 INFO - 'talos_options': ['--xperf_path', 16:16:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:16:32 INFO - 'tests': ['tp5n']}, 16:16:32 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 16:16:32 INFO - 'talos_options': ['--e10s', 16:16:32 INFO - '--xperf_path', 16:16:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 16:16:32 INFO - 'tests': ['tp5n']}}, 16:16:32 INFO - 'talos.zip': {'path': '', 16:16:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 16:16:32 INFO - Running post-action listener: _resource_record_post_action 16:16:32 INFO - ##### 16:16:32 INFO - ##### Running create-virtualenv step. 16:16:32 INFO - ##### 16:16:32 INFO - Running pre-action listener: _resource_record_pre_action 16:16:32 INFO - Running main action method: create_virtualenv 16:16:32 INFO - Creating virtualenv /builds/slave/test/build/venv 16:16:32 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 16:16:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 16:16:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 16:16:32 INFO - Using real prefix '/tools/python27' 16:16:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 16:16:33 INFO - Installing distribute.............................................................................................................................................................................................done. 16:16:36 INFO - Installing pip.................done. 16:16:36 INFO - Return code: 0 16:16:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 16:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1099fa490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099d7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828ad6c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10991e9f0>, '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 0x10967ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099118c8>, '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.EnkqetoiUA/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.Eij1VI7zXq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 16:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 16:16:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EnkqetoiUA/Render', 16:16:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:36 INFO - 'HOME': '/Users/cltbld', 16:16:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:36 INFO - 'LOGNAME': 'cltbld', 16:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:36 INFO - 'MOZ_NO_REMOTE': '1', 16:16:36 INFO - 'NO_EM_RESTART': '1', 16:16:36 INFO - 'PAGER': '/bin/cat', 16:16:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:36 INFO - 'PWD': '/builds/slave/test', 16:16:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:36 INFO - 'SHELL': '/bin/bash', 16:16:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eij1VI7zXq/Listeners', 16:16:36 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 16:16:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:36 INFO - 'USER': 'cltbld', 16:16:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:36 INFO - 'XPC_FLAGS': '0x0', 16:16:36 INFO - 'XPC_SERVICE_NAME': '0', 16:16:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 16:16:36 INFO - Cleaning up... 16:16:36 INFO - Return code: 0 16:16:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 16:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1099fa490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099d7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828ad6c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10991e9f0>, '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 0x10967ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099118c8>, '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.EnkqetoiUA/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.Eij1VI7zXq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:16:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 16:16:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 16:16:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EnkqetoiUA/Render', 16:16:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:36 INFO - 'HOME': '/Users/cltbld', 16:16:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:36 INFO - 'LOGNAME': 'cltbld', 16:16:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:36 INFO - 'MOZ_NO_REMOTE': '1', 16:16:36 INFO - 'NO_EM_RESTART': '1', 16:16:36 INFO - 'PAGER': '/bin/cat', 16:16:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:36 INFO - 'PWD': '/builds/slave/test', 16:16:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:36 INFO - 'SHELL': '/bin/bash', 16:16:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eij1VI7zXq/Listeners', 16:16:36 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 16:16:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:36 INFO - 'USER': 'cltbld', 16:16:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:36 INFO - 'XPC_FLAGS': '0x0', 16:16:36 INFO - 'XPC_SERVICE_NAME': '0', 16:16:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:36 INFO - Downloading/unpacking psutil>=0.7.1 16:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:39 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 16:16:39 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 16:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 16:16:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:39 INFO - Installing collected packages: psutil 16:16:39 INFO - Running setup.py install for psutil 16:16:39 INFO - building 'psutil._psutil_osx' extension 16:16:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 16:16:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 16:16:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 16:16:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 16:16:39 INFO - building 'psutil._psutil_posix' extension 16:16:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 16:16:39 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 16:16:39 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 16:16:39 INFO - ^ 16:16:39 INFO - 1 warning generated. 16:16:39 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 16:16:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 16:16:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 16:16:40 INFO - Successfully installed psutil 16:16:40 INFO - Cleaning up... 16:16:40 INFO - Return code: 0 16:16:40 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 16:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1099fa490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099d7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828ad6c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10991e9f0>, '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 0x10967ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099118c8>, '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.EnkqetoiUA/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.Eij1VI7zXq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:16:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 16:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 16:16:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EnkqetoiUA/Render', 16:16:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:40 INFO - 'HOME': '/Users/cltbld', 16:16:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:40 INFO - 'LOGNAME': 'cltbld', 16:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:40 INFO - 'MOZ_NO_REMOTE': '1', 16:16:40 INFO - 'NO_EM_RESTART': '1', 16:16:40 INFO - 'PAGER': '/bin/cat', 16:16:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:40 INFO - 'PWD': '/builds/slave/test', 16:16:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:40 INFO - 'SHELL': '/bin/bash', 16:16:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eij1VI7zXq/Listeners', 16:16:40 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 16:16:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:40 INFO - 'USER': 'cltbld', 16:16:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:40 INFO - 'XPC_FLAGS': '0x0', 16:16:40 INFO - 'XPC_SERVICE_NAME': '0', 16:16:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:40 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 16:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:42 INFO - Downloading mozsystemmonitor-0.0.tar.gz 16:16:42 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 16:16:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 16:16:42 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 16:16:42 INFO - Installing collected packages: mozsystemmonitor 16:16:42 INFO - Running setup.py install for mozsystemmonitor 16:16:42 INFO - Successfully installed mozsystemmonitor 16:16:42 INFO - Cleaning up... 16:16:42 INFO - Return code: 0 16:16:42 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 16:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1099fa490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099d7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828ad6c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10991e9f0>, '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 0x10967ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099118c8>, '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.EnkqetoiUA/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.Eij1VI7zXq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:16:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 16:16:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 16:16:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EnkqetoiUA/Render', 16:16:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:42 INFO - 'HOME': '/Users/cltbld', 16:16:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:42 INFO - 'LOGNAME': 'cltbld', 16:16:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:42 INFO - 'MOZ_NO_REMOTE': '1', 16:16:42 INFO - 'NO_EM_RESTART': '1', 16:16:42 INFO - 'PAGER': '/bin/cat', 16:16:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:42 INFO - 'PWD': '/builds/slave/test', 16:16:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:42 INFO - 'SHELL': '/bin/bash', 16:16:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eij1VI7zXq/Listeners', 16:16:42 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 16:16:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:42 INFO - 'USER': 'cltbld', 16:16:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:42 INFO - 'XPC_FLAGS': '0x0', 16:16:42 INFO - 'XPC_SERVICE_NAME': '0', 16:16:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:43 INFO - Downloading/unpacking blobuploader==1.2.4 16:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:43 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:43 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 16:16:43 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 16:16:43 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 16:16:45 INFO - Downloading blobuploader-1.2.4.tar.gz 16:16:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 16:16:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 16:16:45 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 16:16:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 16:16:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16:46 INFO - Downloading docopt-0.6.1.tar.gz 16:16:46 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 16:16:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 16:16:46 INFO - Installing collected packages: blobuploader, requests, docopt 16:16:46 INFO - Running setup.py install for blobuploader 16:16:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 16:16:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 16:16:46 INFO - Running setup.py install for requests 16:16:47 INFO - Running setup.py install for docopt 16:16:47 INFO - Successfully installed blobuploader requests docopt 16:16:47 INFO - Cleaning up... 16:16:47 INFO - Return code: 0 16:16:47 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:47 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1099fa490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099d7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828ad6c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10991e9f0>, '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 0x10967ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099118c8>, '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.EnkqetoiUA/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.Eij1VI7zXq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:16:47 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:16:47 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:16:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EnkqetoiUA/Render', 16:16:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:47 INFO - 'HOME': '/Users/cltbld', 16:16:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:47 INFO - 'LOGNAME': 'cltbld', 16:16:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:47 INFO - 'MOZ_NO_REMOTE': '1', 16:16:47 INFO - 'NO_EM_RESTART': '1', 16:16:47 INFO - 'PAGER': '/bin/cat', 16:16:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:47 INFO - 'PWD': '/builds/slave/test', 16:16:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:47 INFO - 'SHELL': '/bin/bash', 16:16:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eij1VI7zXq/Listeners', 16:16:47 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 16:16:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:47 INFO - 'USER': 'cltbld', 16:16:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:47 INFO - 'XPC_FLAGS': '0x0', 16:16:47 INFO - 'XPC_SERVICE_NAME': '0', 16:16:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:47 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-jAZbY7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:47 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-K59kyi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:47 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-Lh0nPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:47 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-hS9wmA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:16:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:16:47 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-63f2Ga-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:16:48 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-T09U5L-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:16:48 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-N36LwR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:16:48 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-52z_Dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:16:48 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-PfVbfz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:16:48 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-vld0YN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:16:48 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-i9MdAn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:16:48 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-epdUhA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:16:48 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-JUJKr4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:16:48 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-bSQPto-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:16:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:48 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-fwDjup-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:16:49 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-SdLxvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:16:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:16:49 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-p5xH2A-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:16:49 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 16:16:49 INFO - Running setup.py install for manifestparser 16:16:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 16:16:49 INFO - Running setup.py install for mozcrash 16:16:49 INFO - Running setup.py install for mozdebug 16:16:49 INFO - Running setup.py install for mozdevice 16:16:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 16:16:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 16:16:49 INFO - Running setup.py install for mozfile 16:16:49 INFO - Running setup.py install for mozhttpd 16:16:50 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 16:16:50 INFO - Running setup.py install for mozinfo 16:16:50 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 16:16:50 INFO - Running setup.py install for mozInstall 16:16:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 16:16:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 16:16:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 16:16:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 16:16:50 INFO - Running setup.py install for mozleak 16:16:50 INFO - Running setup.py install for mozlog 16:16:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 16:16:50 INFO - Running setup.py install for moznetwork 16:16:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 16:16:50 INFO - Running setup.py install for mozprocess 16:16:51 INFO - Running setup.py install for mozprofile 16:16:51 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 16:16:51 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 16:16:51 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 16:16:51 INFO - Running setup.py install for mozrunner 16:16:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 16:16:51 INFO - Running setup.py install for mozscreenshot 16:16:51 INFO - Running setup.py install for moztest 16:16:51 INFO - Running setup.py install for mozversion 16:16:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 16:16:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 16:16:51 INFO - Cleaning up... 16:16:51 INFO - Return code: 0 16:16:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:16:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1099fa490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099d7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828ad6c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10991e9f0>, '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 0x10967ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099118c8>, '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.EnkqetoiUA/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.Eij1VI7zXq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:16:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 16:16:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:16:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EnkqetoiUA/Render', 16:16:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:51 INFO - 'HOME': '/Users/cltbld', 16:16:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:51 INFO - 'LOGNAME': 'cltbld', 16:16:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:51 INFO - 'MOZ_NO_REMOTE': '1', 16:16:51 INFO - 'NO_EM_RESTART': '1', 16:16:51 INFO - 'PAGER': '/bin/cat', 16:16:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:51 INFO - 'PWD': '/builds/slave/test', 16:16:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:51 INFO - 'SHELL': '/bin/bash', 16:16:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eij1VI7zXq/Listeners', 16:16:51 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 16:16:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:51 INFO - 'USER': 'cltbld', 16:16:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:51 INFO - 'XPC_FLAGS': '0x0', 16:16:51 INFO - 'XPC_SERVICE_NAME': '0', 16:16:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 16:16:52 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-UF7MM0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 16:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 16:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 16:16:52 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-6O8xdJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 16:16:52 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)) 16:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 16:16:52 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-8dO1gd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 16:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 16:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 16:16:52 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-MkYBKX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 16:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 16:16:52 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-ZI9w5Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 16:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 16:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 16:16:52 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-qjRQdv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 16:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 16:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 16:16:52 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-mFk2Go-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 16:16:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 16:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 16:16:52 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-cEaxuI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 16:16: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)) 16:16:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 16:16:52 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-EhK_SF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 16:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 16:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 16:16:53 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-6ivVPC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 16:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 16:16:53 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-lEf2Kb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 16:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 16:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 16:16:53 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-bkOp4q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 16:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 16:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 16:16:53 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-CjsAL4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 16:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 16:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 16:16:53 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-BjU0mg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 16:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 16:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:53 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-qiblMp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 16:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 16:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 16:16:53 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-evdzlZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 16:16:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 16:16:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 16:16:53 INFO - Running setup.py (path:/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/pip-WpcTG8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 16:16: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)) 16:16: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)) 16:16: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)) 16:16: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)) 16:16: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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:16: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.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 16:16:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16: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 16:16:55 INFO - Downloading blessings-1.5.1.tar.gz 16:16:55 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 16:16:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 16:16:56 INFO - Installing collected packages: blessings 16:16:56 INFO - Running setup.py install for blessings 16:16:56 INFO - Successfully installed blessings 16:16:56 INFO - Cleaning up... 16:16:56 INFO - Return code: 0 16:16:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 16:16:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:16:56 INFO - Reading from file tmpfile_stdout 16:16:56 INFO - Current package versions: 16:16:56 INFO - blessings == 1.5.1 16:16:56 INFO - blobuploader == 1.2.4 16:16:56 INFO - docopt == 0.6.1 16:16:56 INFO - manifestparser == 1.1 16:16:56 INFO - mozInstall == 1.12 16:16:56 INFO - mozcrash == 0.16 16:16:56 INFO - mozdebug == 0.1 16:16:56 INFO - mozdevice == 0.47 16:16:56 INFO - mozfile == 1.2 16:16:56 INFO - mozhttpd == 0.7 16:16:56 INFO - mozinfo == 0.9 16:16:56 INFO - mozleak == 0.1 16:16:56 INFO - mozlog == 3.0 16:16:56 INFO - moznetwork == 0.27 16:16:56 INFO - mozprocess == 0.22 16:16:56 INFO - mozprofile == 0.27 16:16:56 INFO - mozrunner == 6.11 16:16:56 INFO - mozscreenshot == 0.1 16:16:56 INFO - mozsystemmonitor == 0.0 16:16:56 INFO - moztest == 0.7 16:16:56 INFO - mozversion == 1.4 16:16:56 INFO - psutil == 3.1.1 16:16:56 INFO - requests == 1.2.3 16:16:56 INFO - wsgiref == 0.1.2 16:16:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 16:16: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')]} 16:16:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 16:16:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16: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')]} 16:16:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 16:16:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 16:16:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--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 0x1099fa490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1099d7228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f828ad6c380>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10991e9f0>, '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 0x10967ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099118c8>, '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.EnkqetoiUA/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.Eij1VI7zXq/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 16:16:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 16:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 16:16:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EnkqetoiUA/Render', 16:16:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:16:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:16:56 INFO - 'HOME': '/Users/cltbld', 16:16:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:16:56 INFO - 'LOGNAME': 'cltbld', 16:16:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:16:56 INFO - 'MOZ_NO_REMOTE': '1', 16:16:56 INFO - 'NO_EM_RESTART': '1', 16:16:56 INFO - 'PAGER': '/bin/cat', 16:16:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:16:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:16:56 INFO - 'PWD': '/builds/slave/test', 16:16:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:16:56 INFO - 'SHELL': '/bin/bash', 16:16:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eij1VI7zXq/Listeners', 16:16:56 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 16:16:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:16:56 INFO - 'USER': 'cltbld', 16:16:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:16:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:16:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:16:56 INFO - 'XPC_FLAGS': '0x0', 16:16:56 INFO - 'XPC_SERVICE_NAME': '0', 16:16:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:16:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 16:16: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 1)) 16:16: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 2)) 16:16: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 3)) 16:16: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 4)) 16:16: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 5)) 16:16: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 6)) 16:16: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 7)) 16:16: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 8)) 16:16:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:16: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 3)) 16:16: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.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 16:16:56 INFO - Cleaning up... 16:16:56 INFO - Return code: 0 16:16:56 INFO - Running post-action listener: _resource_record_post_action 16:16:56 INFO - Running post-action listener: _start_resource_monitoring 16:16:56 INFO - Starting resource monitoring. 16:16:56 INFO - ##### 16:16:56 INFO - ##### Running install step. 16:16:56 INFO - ##### 16:16:56 INFO - Running pre-action listener: _resource_record_pre_action 16:16:56 INFO - Running main action method: install 16:16:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 16:16:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 16:16:57 INFO - Reading from file tmpfile_stdout 16:16:57 INFO - Detecting whether we're running mozinstall >=1.0... 16:16:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 16:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 16:16:57 INFO - Reading from file tmpfile_stdout 16:16:57 INFO - Output received: 16:16:57 INFO - Usage: mozinstall [options] installer 16:16:57 INFO - Options: 16:16:57 INFO - -h, --help show this help message and exit 16:16:57 INFO - -d DEST, --destination=DEST 16:16:57 INFO - Directory to install application into. [default: 16:16:57 INFO - "/builds/slave/test"] 16:16:57 INFO - --app=APP Application being installed. [default: firefox] 16:16:57 INFO - mkdir: /builds/slave/test/build/application 16:16:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 16:16:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 16:17:27 INFO - Reading from file tmpfile_stdout 16:17:27 INFO - Output received: 16:17:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 16:17:27 INFO - Running post-action listener: _resource_record_post_action 16:17:27 INFO - ##### 16:17:27 INFO - ##### Running run-tests step. 16:17:27 INFO - ##### 16:17:27 INFO - Running pre-action listener: _resource_record_pre_action 16:17:27 INFO - Running main action method: run_tests 16:17:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:17:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:17:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:17:27 INFO - 2015-11-20 16:17:27.765 screenresolution[2213:16734] starting screenresolution argv=screenresolution get 16:17:27 INFO - 2015-11-20 16:17:27.768 screenresolution[2213:16734] Display 0: 1600x1200x32@60 16:17:27 INFO - 2015-11-20 16:17:27.774 screenresolution[2214:16737] starting screenresolution argv=screenresolution list 16:17:27 INFO - Available Modes on Display 0 16:17:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:17:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:17:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:17:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:17:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:17:28 INFO - Intel Iris: 16:17:28 INFO - Chipset Model: Intel Iris 16:17:28 INFO - Type: GPU 16:17:28 INFO - Bus: Built-In 16:17:28 INFO - VRAM (Dynamic, Max): 1536 MB 16:17:28 INFO - Vendor: Intel (0x8086) 16:17:28 INFO - Device ID: 0x0a2e 16:17:28 INFO - Revision ID: 0x0009 16:17:28 INFO - Displays: 16:17:28 INFO - Display: 16:17:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:17:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:17:28 INFO - Display Serial Number: 1600x1200 60 16:17:28 INFO - Main Display: Yes 16:17:28 INFO - Mirror: Off 16:17:28 INFO - Online: Yes 16:17:28 INFO - Rotation: Supported 16:17:28 INFO - Return code: 0 16:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 16:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 16:17:28 INFO - Python 2.7.3 16:17:28 INFO - Return code: 0 16:17:28 INFO - grabbing minidump binary from tooltool 16:17:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 16:17:28 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 0x10991e9f0>, '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 0x10967ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1099118c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 16:17:28 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 16:17:28 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 16:17:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 16:17:28 INFO - Return code: 0 16:17:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 16:17:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 16:17:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 16:17:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 16:17:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 16:17:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--webServer', 'localhost'] in /builds/slave/test/build 16:17:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0015 --webServer localhost 16:17:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.EnkqetoiUA/Render', 16:17:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 16:17:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 16:17:28 INFO - 'HOME': '/Users/cltbld', 16:17:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 16:17:28 INFO - 'LOGNAME': 'cltbld', 16:17:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 16:17:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 16:17:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 16:17:28 INFO - 'MOZ_NO_REMOTE': '1', 16:17:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 16:17:28 INFO - 'NO_EM_RESTART': '1', 16:17:28 INFO - 'PAGER': '/bin/cat', 16:17:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 16:17:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 16:17:28 INFO - 'PWD': '/builds/slave/test', 16:17:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 16:17:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 16:17:28 INFO - 'SHELL': '/bin/bash', 16:17:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Eij1VI7zXq/Listeners', 16:17:28 INFO - 'TMPDIR': '/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/', 16:17:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 16:17:28 INFO - 'USER': 'cltbld', 16:17:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 16:17:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 16:17:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 16:17:28 INFO - 'XPC_FLAGS': '0x0', 16:17:28 INFO - 'XPC_SERVICE_NAME': '0', 16:17:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 16:17:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0015', '--webServer', 'localhost'] with output_timeout 3600 16:17:28 INFO - mozversion INFO | application_buildid: 20151120132233 16:17:28 INFO - mozversion INFO | application_changeset: b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73 16:17:28 INFO - mozversion INFO | application_display_name: Nightly 16:17:28 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 16:17:28 INFO - mozversion INFO | application_name: Firefox 16:17:28 INFO - mozversion INFO | application_remotingname: firefox 16:17:28 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 16:17:28 INFO - mozversion INFO | application_vendor: Mozilla 16:17:28 INFO - mozversion INFO | application_version: 45.0a1 16:17:28 INFO - mozversion INFO | platform_buildid: 20151120132233 16:17:28 INFO - mozversion INFO | platform_changeset: b0bdf1bc3b61fbe002d820ba0bd88ebedae92b73 16:17:28 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 16:17:28 INFO - mozversion INFO | platform_version: 45.0a1 16:17:28 INFO - 2015-11-20 16:17:28,308 DEBUG : using testdate: 1448065048 16:17:28 INFO - 2015-11-20 16:17:28,308 DEBUG : actual date: 1448065048 16:17:28 INFO - 2015-11-20 16:17:28,794 INFO : starting webserver on 'localhost:50925' 16:17:28 INFO - 2015-11-20 16:17:28,794 INFO : Starting test suite t-yosemite-r7-0015.e 16:17:28 INFO - 2015-11-20 16:17:28,795 INFO : Starting test dromaeo_css 16:17:28 INFO - 2015-11-20 16:17:28,795 DEBUG : operating with platform_type : mac_ 16:17:28 INFO - 2015-11-20 16:17:28,796 INFO : Initialising browser for dromaeo_css test... 16:17:28 INFO - 2015-11-20 16:17:28,808 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpHJTlLj/profile http://localhost:50925/getInfo.html 16:17:31 INFO - 2015-11-20 16:17:31,438 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:17:31 INFO - 2015-11-20 16:17:31,438 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:17:31 INFO - 2015-11-20 16:17:31,438 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:17:31 INFO - 2015-11-20 16:17:31,438 DEBUG : BROWSER_OUTPUT: __metrics 16:17:32 INFO - 2015-11-20 16:17:32,122 INFO : Browser initialized. 16:17:32 INFO - 2015-11-20 16:17:32,122 INFO : Running cycle 1/1 for dromaeo_css test... 16:17:32 INFO - 2015-11-20 16:17:32,122 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpHJTlLj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:17:44 INFO - 2015-11-20 16:17:44,155 DEBUG : BROWSER_OUTPUT: RSS: Main: 237154304 16:17:44 INFO - 2015-11-20 16:17:44,155 DEBUG : BROWSER_OUTPUT: 16:18:33 INFO - 2015-11-20 16:18:33,862 DEBUG : BROWSER_OUTPUT: 1448065113862 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] 16:20:44 INFO - 2015-11-20 16:20:44,924 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50925/tests/dromaeo/cssquery-ext.html) 16:20:46 INFO - 2015-11-20 16:20:46,137 DEBUG : BROWSER_OUTPUT: RSS: Main: 252981248 16:20:46 INFO - 2015-11-20 16:20:46,137 DEBUG : BROWSER_OUTPUT: 16:23:48 INFO - 2015-11-20 16:23:48,126 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/dromaeo/cssquery-ext.html (next: http://localhost:50925/tests/dromaeo/cssquery-jquery.html) 16:23:48 INFO - 2015-11-20 16:23:48,713 DEBUG : BROWSER_OUTPUT: RSS: Main: 262668288 16:23:48 INFO - 2015-11-20 16:23:48,713 DEBUG : BROWSER_OUTPUT: 16:26:50 INFO - 2015-11-20 16:26:50,318 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50925/tests/dromaeo/cssquery-mootools.html) 16:26:50 INFO - 2015-11-20 16:26:50,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 262897664 16:26:50 INFO - 2015-11-20 16:26:50,916 DEBUG : BROWSER_OUTPUT: 16:29:52 INFO - 2015-11-20 16:29:52,481 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50925/tests/dromaeo/cssquery-prototype.html) 16:29:53 INFO - 2015-11-20 16:29:53,083 DEBUG : BROWSER_OUTPUT: RSS: Main: 266063872 16:29:53 INFO - 2015-11-20 16:29:53,083 DEBUG : BROWSER_OUTPUT: 16:32:55 INFO - 2015-11-20 16:32:55,661 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50925/tests/dromaeo/cssquery-yui.html) 16:32:56 INFO - 2015-11-20 16:32:56,271 DEBUG : BROWSER_OUTPUT: RSS: Main: 268869632 16:32:56 INFO - 2015-11-20 16:32:56,271 DEBUG : BROWSER_OUTPUT: 16:35:58 INFO - 2015-11-20 16:35:58,470 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/dromaeo/cssquery-yui.html (next: http://localhost:50925/tests/dromaeo/cssquery-dojo.html) 16:35:58 INFO - 2015-11-20 16:35:58,727 DEBUG : BROWSER_OUTPUT: RSS: Main: 271060992 16:35:58 INFO - 2015-11-20 16:35:58,727 DEBUG : BROWSER_OUTPUT: 16:35:58 INFO - 2015-11-20 16:35:58,727 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:35:58 INFO - 2015-11-20 16:35:58,727 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:35:58 INFO - 2015-11-20 16:35:58,727 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:35:58 INFO - 2015-11-20 16:35:58,727 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:35:58 INFO - 2015-11-20 16:35:58,727 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3273.836308184591;3509.1402606361444;3523.3305671922317;3544.0431083607427;3550.6804387605125;4640.67515273931;5728.656280623166;5855.970720146399;5929.673867937262;5946.4945479634225;5873.353931067579;5878.441548052939;5995.880082398349;6026.216591843055;6064.727087281072;5297.973510132444;5346.304980352549;5354.544863686591;5435.239066530669;5451.373092094401;4517.570830771071;5410;5430.8913821723545;5446.373667028302;5466.070767969455;5150.896982060375;5206.609504287175;5283.55089817366;5287.920681189786;5316.574674026068;5287.021900948298;5289.444608316148;5309.044372013036;5349.946500534984;5353.678779273256;5148.9742551287;5282.128448805943;5311.362636483646;5335.279737235463;5365.651232669864;4496.3705081288645;5348.946510534884;5630.5495560355075;5797.768089276466;5822.883542329172;6326.240851097898;6355.5551111421755;6356.173697419306;6369.140166077566;6393.520485963525;6191.659458729768;6309.580344422468;6362.300146983828;6407.807765766988;6414.967925160391;5916.408359164092;5993.9700301498215;6012.579119461596;6014.879702405928;6075.665838378932;6376.011718183689;6454.451371633464;6478.740850365933;6513.837154071091;6527.34726527353;5965.880682386415;6150.7232174552255;6214.285357183981;6315.210598675166;6328.493720502441;6373.6175829450385;6391.808245752635;6400.551961362753;6413.551051426355;6416.326285740023;6323.873522529616;6326.746930122744;6334.398232167937;6335.68321583919;6338.524610654219;6147.877042459215;6154.430430350386;6279.246490421087;6304.432601065926;6323.494120470351;4939.036887806843;4939.802407903716;4949.529794669501;4960.131976904027;5100.464451232567;4440.045390241114;4454.7549884756;4474.194644963938;4477.104579084131;4478.932816007762;5838.591298609142;5840.182374467578;5933.2286802716235;5990.191324171181;6058.666773327509;6340.685649737905;6356.713947872357;6362.236531616143;6362.522810789209;6394.680265986682;5794.1308803679785;6054.243219597551;6072.969635151796;6087;6104.389561043949;5456.127019676833;5494.230807686927;5531.889362212733;5546.445355464502;5579.218909352694;6455.870222711101;6470.514711396664;6506.41442270198;6523.151990241333;6551.017347397833;6157.476614487819;6217.036359364306;6306.558540902276;6311.337309582428;6324.905126423199;6311.211098612674;6339.461145802658;6382.457491113308;6393.264774550986;6404.391582799627;6247.468965138014;6281.183446151971;6292.590981586182;6300.9684951574945;6302.779402720883;6132.4166970161305;6139.26328840542;6245.718942647501;6340.9365906340345;6360.077788720702;6234.657093859882;6248.156498872594;6255.124282600348;6262.624242545462;6264.279607844974;6084.939150608438;6215.378462153749;6233.065040244;6234.314225435289;6252.843678908063;5006.674566153189;5973.462388385066;5983.9401605983385;6021.187139736079;6168.228971378578;6257.874842503215;6289.779857704958;6298.496120310456;6303.810885673437;6340.365963403623;5091.007253585663;6227.657478838707;6227.9377206227355;6229.470495007975;6233.252009758677 16:35:58 INFO - 2015-11-20 16:35:58,727 DEBUG : BROWSER_OUTPUT: |1;ext.html;558.7764894042385;580.7676929228311;584.2171490203128;584.9587733833774;590.9481123599993;42043.57956420435;42803.785981070054;42903.570964290346;43048.78475607622;43087.78456107719;45623.087538249216;45864.54135458644;45923;46128.53871461293;46150.7692461538;9842.655507057272;9955.701328960144;10013.349132306414;10041.899581004169;10067;9846.507674616276;9917.801643967116;9961.35251208669;9968.003199680046;9983.40099594023;9830.115289623933;9864.260180486457;9878.60485580576;9895.208383329353;9905.950470247639;9861.506924653775;9908.801823963517;9958.103770660675;9971.501424928798;9983.351082179672;9757.170640495495;9864.704058878173;9913.256505762096;9916.355436896578;9929.65246216379;42260.57739422597;42324.576754232374;42399.57600423987;42641.78679106616;42792;2809.1712944681367;3225.193701574606;3278.327942771726;3387.7459190560808;3457.550518432613;28798.712012879812;29600.70399296001;29706.851465742748;29712.702872971426;29940;2795.5247607906704;2802.047303916678;2835.4045650413436;2873.094975082863;2996.6104406427244;489665;490695;493394;494529;494789;46595.5340446598;47098;47123.29315060277;47251;47254.81862953454;46470.53529464662;46561.767191163824;46589.06821863544;46784.7660761694;46785.76607117011;15640.687186256211;15739.976901501366;15744.685106298039;15749.370025199092;15791.131487768052;12485.50057997688;12513.624591262276;12660.17708848922;12723.936380318039;12945.741085178432;15307.846921530865;15317.6170595736;15318.702194670888;15333.31000104998;15463.38146474151;6156.6921653918025;6189.885820552254;6622.37087476689;6663.167104111986;6684.231313398924;831.9708810191614;959.712086374085;1031.6079889641887;1117.5473933057124;1210.673118258083;33555.328893421996;33813.323733525685;34051.14872128167;34206.82896585501;34236.31527369488;1073.4847273308856;1088.8257878739523;1092.1972350322508;1098.8132017557034;1210.5036934856666;14850.92574537142;15721.528354149394;17148.31406743741;17348.65302693939;17459.912700436416;673501;683029;692917;699809;703728;63432;63796;64249.67875160594;64479.03281450782;64594.67702661551;1411.089847048648;1438.280859570215;1451.9419223231164;1456.3155317000992;1605.9320551833134;31296.530552042193;31392.215194620316;31551.55275159482;31567;32023.199420014687;52773.7361313191;52798.68003299948;53249.20126198033;53249.733751331;53291;509857;511298;512737;513453;516925;32962.17594560155;33700.32599348048;33792.324153517286;34093.613447058466;34288;45369;46138;46413;46571.53428465672;46820.29769553391;37076.70231541883;38866.61133388743;40917.59082409257;41332.58667413408;42886.92782680458;38361.040973975876;39113;39204.41193382159;39315;41186.588134118276;37547.81226093852;38325.808370957966;38345.041373964756;38545.61454385532;38796.61203388043;32891.50662740109;34228.828855856555;34367.48448773321;34546.30907381788;34666.9599912003;21608.567828643652;26213;27294;27603.72396276092;28662.713372866005 16:35:58 INFO - 2015-11-20 16:35:58,729 DEBUG : BROWSER_OUTPUT: |2;jquery.html;357.20521838908434;363.81445462813963;366.13409287036166;366.27477594363154;366.28208710926583;16106.758398624;19562;20759.273425430096;21253.468663283387;21485.57028859422;11703.53185872564;15351.923240383783;18540.44378668642;18852.62294754104;19819.60360792783;4500.482444518873;4561.749103799298;5227.921581176285;5458.181272809071;5630.971845140769;4748.97625511872;5577;5638.295213098363;5659.66042037477;5665.801696940608;5365;5453.3728621208675;5463.672179669213;5463.945360546403;5491.066518691832;5642.576806739511;5788.913166302509;5834.6790926499025;5858.3848695886745;5878.853028674296;5593.440655934414;5613.775448982076;5641.069223578104;5648.548116150698;5653.773849046074;10791.082757965582;17008.914955425145;17119.116897141306;24383.390415239584;25415;1984.7915968823354;2070.6997485364686;2099.601075795594;2101.53766171442;2109.683547467877;8386.790330241793;9306.441613503144;9739.90260097397;10032.197424206046;14824.555263342118;1484.680793629364;1749.2128542155954;1795;1824.4982629776785;1837.1273645018643;102745;107022.99999999921;109535;112556.43721781339;112628;11176.385298808644;11291.548338066385;11329.546818127183;11410.657680269605;11421.31472111676;13419.86580134186;13420.664483387993;13429.932850335881;13449.260290684106;13536.661583460493;8606.827863442697;8621.525816080175;8636.913630863737;8637.438566493158;8684.522351270742;8778.780530486662;8791.604377803014;8807.867881981776;8822.470651760916;8825.38222324444;4011.237864805736;4152.190322887008;4207.558206388347;4283.978580107079;4292.3561465780385;1621.7405215165518;1833.8899666020081;1849.7595312609274;1888.9338873139375;1927.0461121744827;884.5533005832013;932.7574830543972;943.2831048403126;990.8414653655525;1074.301703892476;16977.3347313809;19875.701864472045;21171.68242476364;21255.655604065556;22724.886375568018;876.3120950054305;923.8660394242931;958.726762872578;965.652365148546;968.6658102954469;11099.44502774858;11339.206255562032;11472.94263528677;11490.482928268248;11502.022328102037;759055;760640;764932;770785;777464;55713.60715982133;59830.70084649636;59959.10061349083;65326.673366632866;127879.72120278678;1022.192467950311;1105.4693747001324;1201.069171392178;1229.4590380232669;1234.3581337704163;15301.46444874424;18887.622247555246;19162;19372;19373.51566210856;40558;46249;48106.75946620244;50345.74827125987;50908.74545627248;52478.737606311726;75985;78943.21056789359;81093.97265068184;81720.18279817126;8597.742067737978;9860.753481162741;9906.504674766376;10111.797764044824;10156.847647285149;15629.687406251584;18710.158042888375;19218.807811921703;20055.398338049883;20158.39524814258;13354.732905342033;15408;15440.45958391451;15672.746180305776;16008.119553424207;13339.733205336033;14888.330025148678;14985.625359365667;15496.84503154954;15971.041737495787;15825.208739563206;16286;16542.42101526441;16568;17038.48884533466;9385.249180065715;9584.856227156459;9692.41845489273;9736.367136136128;9751.073648003428;10284.177265818866;14370.928145359625;14840;15340.846591533942;16612.335506579602 16:35:58 INFO - 2015-11-20 16:35:58,730 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1554.549180737586;1599.3442688497719;1919.0500702152433;1964.8329891959183;1975.950601234968;7810.336121429671;7882.842343153148;8281.13048129946;8625.396222264437;8695.73912782616;8190.303824174952;8377.204165604273;8424.410291279597;8464.788380290496;8465.49207047576;2379.345679938018;2391.80865530758;2418.4800267942387;2419.818513611486;2420.5642984262827;2422.4791669790993;2439.85360878347;2465.864377459239;2466.7903228225623;2478.4547399572066;2396.1972739132325;2403.5793736096202;2418.600930846417;2428.138011006085;2441.2554170977846;2380.642903564462;2399.416385185778;2405.1461731085474;2406.568091985266;2414.6860908081926;2371.513839662865;2374.798142157919;2377.7265614454386;2382.106709983756;2382.5711371953043;8385.916140838575;8470.534120623362;8486.363522735819;8511.319094472488;8513.53175575343;4743.810247590092;5179.249008893689;5262.473752624745;5264.263003179558;5276.182191760245;2923.4445455363625;3120.7035331643456;3495.318412909484;3504.281622267429;3563.1626567756557;1053.6206965492418;1065.690949624608;1075.9731006724894;1092.9289596176222;1097.4841824342545;11015.394153321484;11086.667399978014;11163.776724465546;11171;11204.375365572028;4747.240441529339;4782.832600858953;4813.927791083137;4830.589399901048;4841.757912104451;9664.90335096654;9668.806623867624;9718.805623887483;9720.319577629498;9734.172595329477;5216.713080780518;5240.34495688039;5249.055170069348;5272.05103081449;5293.920591191135;4711.929321060187;4780.282957556325;4835.8065677372515;4841.612670986313;4863.221884498464;3340.4488259437408;3879.3211188042546;3918.1575961168487;3928.7249892507252;3931.0958479549863;1299.707565797688;1304.2891624064907;1312.0880987713447;1314.8882345000782;1319.6239071864472;1339.872712092369;1347.070521340272;1362.0329566008245;1363.2433999130578;1404.7822587498954;7813.257740514642;7875.803104922308;7924.088729796147;7928.722494712657;7941.245581669732;492.07981075388534;496.10205527994447;497.3360563647499;499.9550040496373;506.41256142874823;6022.066579680157;6086.847828804227;6140.969295153495;6145.5698101133385;6161.229846269216;10072.446015469219;10133.898661013296;10154.289199755945;10205.438700871524;10222.386656800616;8521.403501754941;9725.416475011521;10065.899341006496;10068.546915388824;10119.595216191417;7906.090799558009;7928.643211055516;7937.801554961056;7996.160403157584;7999.280064794197;7830.177831327628;7848.921510785048;7909.485883417559;7914.960425197837;7918.406119541172;8989.505577193317;9137.954310228406;9172.724818255463;9196.172344489029;9237.307201959746;9314.394564353295;9485.573149208165;9486.430814151174;9618.086281803218;9667.033296670277;7477.663505142173;7524.247575242432;7534.246575342422;7537.434692398202;7550.433717471102;8006.079300880473;8087.595620219083;8133.552654604054;8156.429049966446;8168.346532277523;7541.660625271986;7609.885851712118;7615;7616.657250423855;7701.614919254127;7415;7448.1807001228735;7531.774046778605;7539.773806785805;7641.808954776175;6424.678766061772;6736.056952026622;7325.890111648436;7410.8147296315865;7540.509866858637;6784.253732089367;6862.4853136014;6868.347506986828;6873.965630171817;6879.036934829228;6167.074938759222;6842.281560436082;6895;6904.585724856524;6916.446684265146 16:35:58 INFO - 2015-11-20 16:35:58,734 DEBUG : BROWSER_OUTPUT: |4;prototype.html;287.32192026816693;322.78857348436776;326.3179953896356;331.62195097588744;332.938406394817;5994.771071930255;6236.469900058489;7009.579425234483;7051.435885129184;7083.39791117755;6816.55692379995;6958.8260293492685;6989.965050174755;7044.295570442953;7056.400205982485;5156.53591176794;5163.406208286039;5177.87055323618;5187.962407518493;5198.45416231296;3989.9800500997453;5157.123289040854;5188.4811518848;5194.610404219679;5213.843584692465;4372.912541749163;4913.697870064436;4945.653804233705;4971.577415919651;4983.352164218646;4669.9066018679605;4939.950600494003;4984.77568509418;4990.4261009983775;5005.774740136666;3534.1871369584883;4165.333546632524;4173.332266837322;4204.705670603059;4246.617804397619;6705.094812200388;6709.832254193635;6726.461883049345;6771.458283337371;6774.288699686511;4895.510448955111;5914;5941.346451890288;5981.282246130492;5997.370276120988;7235.89146162808;7458.664360103809;7462.925370746331;7479.887801682979;7485.0643669541305;4760.523947605247;4768.880777980578;4769.761511924425;4779.330893674888;4780.760961951889;7844.529328240324;7906.209379062106;7917.960410197969;7924.445288829726;7932.7223547176145;3953.9011524712114;3979.343408337592;4194;4619.313950408144;4832.492588278251;4054.4526488924207;4343.804528796211;4868.513148685174;4927.90144197114;4934.703917764946;5923.733431995571;5938.079597662369;5949.1076338549565;5986;5990.850228744229;6418.967905160444;6494.318096599884;7537;7580.128285247157;7643.656035478417;1561.3910574875808;1645.6873194093084;1649.8762592805347;1718.2096235731453;1719.2693105430142;959.8146289332668;1037.1702637889657;1090.220492347975;1095.0308976555646;1097.401915955806;5733.627314224562;7072.575645461289;7075.327843854826;7096.183938846995;7127.5010749248095;7822.1004584472375;7823.804404889924;7869.291763741291;7872.645730942121;7884.842303153905;5778.393268706725;6931.757388491378;7071.469639777038;7081.291870812877;7215.60314182725;4051.1290072633938;4103.322951712934;4110.0752330725345;4160.708750387444;4195.391668208093;8105.230003149692;8132.959335203286;8151.470154439942;8157.510549367057;8180.427370084156;6560.573562718408;7876.212378762078;8108.2297181767635;8131.634076466573;8140.308073813674;7323.084614423197;7546.735864244725;8122.593870306461;8141.267285944294;8153.1846815317995;7884.566348850868;7904.604769761374;7917.881231781413;7940.205979402013;7943.801404964922;7527.6988920444755;7746.690132394641;7749.457537972513;7754.7673569793;7778.299953004257;8121.106678265268;8138.511689298661;8145.307648849677;8161.673533058611;8179.100298967228;4847.22444408907;4856.975715121402;4883.658143929891;4888.437829649636;4904.975475122602;7654.770356889302;7895.289423951642;7928.682852685828;7929.326007289214;7933.8413231736195;7623.580703061385;7658.349040331635;7658.540487570764;7673.884891726517;7689.769306920802;7381.224971378143;7531.133919599316;7593.126790419173;7613.857921311847;7614.885776713243;7343.77968660941;7390.630468476447;7395.963020184865;7397.8150546236775;7399.445041621792;7548.094228692592;7561.168271490022;7573.507721998052;7590.430717696085;7618.276263754934;7207.423406127392;7438.516496427715;7452.21751716062;7465.440091993014;7490.475666703279 16:35:58 INFO - 2015-11-20 16:35:58,735 DEBUG : BROWSER_OUTPUT: |5;yui.html;725.3653053578118;808.2442915873662;815.930645895099;835.4026870787386;860.7331727164576;12615.55845545406;12889.419976101075;12929.353532323394;12961.805572916403;13010.739785204314;14172.078814877052;14262.072965257252;14262.215578143197;14270.643233919158;14304.642383940407;746.9103707555101;764.9978528128142;928.1971095002808;944.763809047738;945.1068740040664;873.8863947686792;916.6150216908915;927.9164875161234;942.0532364973193;945.9148676619103;992.4591097851652;1003.794222184454;1009.8081364540714;1011.2617789014024;1012.7620009297809;984.1142971325793;987.3730181334832;995.8307087795056;999.8400255959011;1004.9899501004969;608.8082254089948;706.1526168597652;735.4888352594949;738.2101151767611;751.4476859508258;14745.11529308245;14924.403023879031;14954;14988.550343489713;15102.093874367463;11907.16649834512;12274;12564.811527826998;12606.74786504274;12779.041571882146;10171.135453486462;10279.383237005804;10406.635767748092;10672.78654426907;10953.397563134024;3466.272082862602;3579.552555930509;3587.0673624857463;3593.317269718745;3624.855005799765;66963.3303666962;80084.19915800884;81928;81932.9999999994;82085;9684.322097453252;9827.705168844803;9877.308588398742;9917.900820991697;10469.371837689763;21271.36185914425;21499;21505.892470537547;21544.676829847565;21740.45648858791;7359.448041396917;7424.665890034961;7597.392208623297;7649.502782319131;7775.261350171724;4065.8170382332864;4152.792360382029;4226.1336426032585;4260.10537787062;4270.50889147752;3458.5330980317335;3519.1905861651962;3521.29574085184;3524.9118772030392;3527.8412471438846;623.7972658885881;632.8607706304606;636.38270877249;653.9771108011197;658.8517583543664;504.66187654271727;508.123486984948;524.6851888866726;531.0891820527813;534.2040359863774;8665.43674661145;8741.08218637034;8755.693550725695;8769.736907892773;8927.910720892838;493.1197811905803;493.43255256455365;495.5490503641669;537.0092179928105;541.9241306217133;4027.81874815634;4140.4617399738445;4150.335946248586;4239.27932251518;4267.573242675708;94769;96190;97014;97043.51478242705;100767;67902.66048669725;86710.56644716737;87950.56024719836;88716.5564172175;88806.11193888108;76967.61516192384;77620;77815;77870.83193752098;79288;8282.213189746964;8336.666533338841;8478.491290522341;8527.658893644184;8588.957055214683;51933.441996740155;52619.73690131525;53017.4698253028;53292.46707532875;54242.728786355816;73134.26865731274;73508.63245683737;73519.63240183765;77230;78074.6096269515;10996.12031037531;11100.167487438635;11364.431778411212;11503.76992460163;11824;12044.939775301418;12079.335636540074;12087.214331068453;12088.456019478968;12237.388130593612;11482.82775758381;11954.940225298818;12020.579279725167;12067.975202519374;12353.32056736888;9597.520123993912;9873;11157.49791259379;11835.349055802013;11896.940515297714;9356.859647105162;9907.306488545733;10444.373337599769;10897.237193396386;11152.442377881236;9354.906450935403;9512.191463725661;9532.189763869872;9905.207583393456;10086.394816311045;9016.59425325875;9399;9789.51052447389;9835.918049014459;9937.900620993698 16:35:58 INFO - 2015-11-20 16:35:58,735 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:35:58 INFO - 2015-11-20 16:35:58,735 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:35:58 INFO - 2015-11-20 16:35:58,735 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,341 16:35:58 INFO - 2015-11-20 16:35:58,735 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:35:58 INFO - 2015-11-20 16:35:58,736 DEBUG : BROWSER_OUTPUT: __startTimestamp1448066158721__endTimestamp 16:35:58 INFO - 2015-11-20 16:35:58,736 DEBUG : BROWSER_OUTPUT: 16:35:58 INFO - 2015-11-20 16:35:58,736 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:35:58 INFO - 2015-11-20 16:35:58,736 DEBUG : BROWSER_OUTPUT: Number of tests: 6 16:35:58 INFO - 2015-11-20 16:35:58,736 DEBUG : BROWSER_OUTPUT: 16:35:58 INFO - 2015-11-20 16:35:58,736 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5843.71 Median:6132.42 stddev:677.17 (11.0%) stddev-sans-first:648.55 16:35:58 INFO - 2015-11-20 16:35:58,737 DEBUG : BROWSER_OUTPUT: Values: 3273.8 3509.1 3523.3 3544.0 3550.7 4640.7 5728.7 5856.0 5929.7 5946.5 5873.4 5878.4 5995.9 6026.2 6064.7 5298.0 5346.3 5354.5 5435.2 5451.4 4517.6 5410.0 5430.9 5446.4 5466.1 5150.9 5206.6 5283.6 5287.9 5316.6 5287.0 5289.4 5309.0 5349.9 5353.7 5149.0 5282.1 5311.4 5335.3 5365.7 4496.4 5348.9 5630.5 5797.8 5822.9 6326.2 6355.6 6356.2 6369.1 6393.5 6191.7 6309.6 6362.3 6407.8 6415.0 5916.4 5994.0 6012.6 6014.9 6075.7 6376.0 6454.5 6478.7 6513.8 6527.3 5965.9 6150.7 6214.3 6315.2 6328.5 6373.6 6391.8 6400.6 6413.6 6416.3 6323.9 6326.7 6334.4 6335.7 6338.5 6147.9 6154.4 6279.2 6304.4 6323.5 4939.0 4939.8 4949.5 4960.1 5100.5 4440.0 4454.8 4474.2 4477.1 4478.9 5838.6 5840.2 5933.2 5990.2 6058.7 6340.7 6356.7 6362.2 6362.5 6394.7 5794.1 6054.2 6073.0 6087.0 6104.4 5456.1 5494.2 5531.9 5546.4 5579.2 6455.9 6470.5 6506.4 6523.2 6551.0 6157.5 6217.0 6306.6 6311.3 6324.9 6311.2 6339.5 6382.5 6393.3 6404.4 6247.5 6281.2 6292.6 6301.0 6302.8 6132.4 6139.3 6245.7 6340.9 6360.1 6234.7 6248.2 6255.1 6262.6 6264.3 6084.9 6215.4 6233.1 6234.3 6252.8 5006.7 5973.5 5983.9 6021.2 6168.2 6257.9 6289.8 6298.5 6303.8 6340.4 5091.0 6227.7 6227.9 6229.5 6233.3 16:35:58 INFO - 2015-11-20 16:35:58,737 DEBUG : BROWSER_OUTPUT: 16:35:58 INFO - 2015-11-20 16:35:58,737 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:69951.73 Median:42152.08 stddev:152990.48 (362.9%) stddev-sans-first:153330.95 16:35:58 INFO - 2015-11-20 16:35:58,739 DEBUG : BROWSER_OUTPUT: Values: 558.8 580.8 584.2 585.0 590.9 42043.6 42803.8 42903.6 43048.8 43087.8 45623.1 45864.5 45923.0 46128.5 46150.8 9842.7 9955.7 10013.3 10041.9 10067.0 9846.5 9917.8 9961.4 9968.0 9983.4 9830.1 9864.3 9878.6 9895.2 9906.0 9861.5 9908.8 9958.1 9971.5 9983.4 9757.2 9864.7 9913.3 9916.4 9929.7 42260.6 42324.6 42399.6 42641.8 42792.0 2809.2 3225.2 3278.3 3387.7 3457.6 28798.7 29600.7 29706.9 29712.7 29940.0 2795.5 2802.0 2835.4 2873.1 2996.6 489665.0 490695.0 493394.0 494529.0 494789.0 46595.5 47098.0 47123.3 47251.0 47254.8 46470.5 46561.8 46589.1 46784.8 46785.8 15640.7 15740.0 15744.7 15749.4 15791.1 12485.5 12513.6 12660.2 12723.9 12945.7 15307.8 15317.6 15318.7 15333.3 15463.4 6156.7 6189.9 6622.4 6663.2 6684.2 832.0 959.7 1031.6 1117.5 1210.7 33555.3 33813.3 34051.1 34206.8 34236.3 1073.5 1088.8 1092.2 1098.8 1210.5 14850.9 15721.5 17148.3 17348.7 17459.9 673501.0 683029.0 692917.0 699809.0 703728.0 63432.0 63796.0 64249.7 64479.0 64594.7 1411.1 1438.3 1451.9 1456.3 1605.9 31296.5 31392.2 31551.6 31567.0 32023.2 52773.7 52798.7 53249.2 53249.7 53291.0 509857.0 511298.0 512737.0 513453.0 516925.0 32962.2 33700.3 33792.3 34093.6 34288.0 45369.0 46138.0 46413.0 46571.5 46820.3 37076.7 38866.6 40917.6 41332.6 42886.9 38361.0 39113.0 39204.4 39315.0 41186.6 37547.8 38325.8 38345.0 38545.6 38796.6 32891.5 34228.8 34367.5 34546.3 34667.0 21608.6 26213.0 27294.0 27603.7 28662.7 16:35:58 INFO - 2015-11-20 16:35:58,739 DEBUG : BROWSER_OUTPUT: 16:35:58 INFO - 2015-11-20 16:35:58,739 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:38017.54 Median:21254.56 stddev:125710.97 (591.5%) stddev-sans-first:126031.81 16:35:58 INFO - 2015-11-20 16:35:58,740 DEBUG : BROWSER_OUTPUT: Values: 357.2 363.8 366.1 366.3 366.3 16106.8 19562.0 20759.3 21253.5 21485.6 11703.5 15351.9 18540.4 18852.6 19819.6 4500.5 4561.7 5227.9 5458.2 5631.0 4749.0 5577.0 5638.3 5659.7 5665.8 5365.0 5453.4 5463.7 5463.9 5491.1 5642.6 5788.9 5834.7 5858.4 5878.9 5593.4 5613.8 5641.1 5648.5 5653.8 10791.1 17008.9 17119.1 24383.4 25415.0 1984.8 2070.7 2099.6 2101.5 2109.7 8386.8 9306.4 9739.9 10032.2 14824.6 1484.7 1749.2 1795.0 1824.5 1837.1 102745.0 107023.0 109535.0 112556.4 112628.0 11176.4 11291.5 11329.5 11410.7 11421.3 13419.9 13420.7 13429.9 13449.3 13536.7 8606.8 8621.5 8636.9 8637.4 8684.5 8778.8 8791.6 8807.9 8822.5 8825.4 4011.2 4152.2 4207.6 4284.0 4292.4 1621.7 1833.9 1849.8 1888.9 1927.0 884.6 932.8 943.3 990.8 1074.3 16977.3 19875.7 21171.7 21255.7 22724.9 876.3 923.9 958.7 965.7 968.7 11099.4 11339.2 11472.9 11490.5 11502.0 759055.0 760640.0 764932.0 770785.0 777464.0 55713.6 59830.7 59959.1 65326.7 127879.7 1022.2 1105.5 1201.1 1229.5 1234.4 15301.5 18887.6 19162.0 19372.0 19373.5 40558.0 46249.0 48106.8 50345.7 50908.7 52478.7 75985.0 78943.2 81094.0 81720.2 8597.7 9860.8 9906.5 10111.8 10156.8 15629.7 18710.2 19218.8 20055.4 20158.4 13354.7 15408.0 15440.5 15672.7 16008.1 13339.7 14888.3 14985.6 15496.8 15971.0 15825.2 16286.0 16542.4 16568.0 17038.5 9385.2 9584.9 9692.4 9736.4 9751.1 10284.2 14370.9 14840.0 15340.8 16612.3 16:35:58 INFO - 2015-11-20 16:35:58,740 DEBUG : BROWSER_OUTPUT: 16:35:58 INFO - 2015-11-20 16:35:58,741 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5861.24 Median:5274.12 stddev:3044.26 (57.7%) stddev-sans-first:3035.59 16:35:58 INFO - 2015-11-20 16:35:58,741 DEBUG : BROWSER_OUTPUT: Values: 1554.5 1599.3 1919.1 1964.8 1976.0 7810.3 7882.8 8281.1 8625.4 8695.7 8190.3 8377.2 8424.4 8464.8 8465.5 2379.3 2391.8 2418.5 2419.8 2420.6 2422.5 2439.9 2465.9 2466.8 2478.5 2396.2 2403.6 2418.6 2428.1 2441.3 2380.6 2399.4 2405.1 2406.6 2414.7 2371.5 2374.8 2377.7 2382.1 2382.6 8385.9 8470.5 8486.4 8511.3 8513.5 4743.8 5179.2 5262.5 5264.3 5276.2 2923.4 3120.7 3495.3 3504.3 3563.2 1053.6 1065.7 1076.0 1092.9 1097.5 11015.4 11086.7 11163.8 11171.0 11204.4 4747.2 4782.8 4813.9 4830.6 4841.8 9664.9 9668.8 9718.8 9720.3 9734.2 5216.7 5240.3 5249.1 5272.1 5293.9 4711.9 4780.3 4835.8 4841.6 4863.2 3340.4 3879.3 3918.2 3928.7 3931.1 1299.7 1304.3 1312.1 1314.9 1319.6 1339.9 1347.1 1362.0 1363.2 1404.8 7813.3 7875.8 7924.1 7928.7 7941.2 492.1 496.1 497.3 500.0 506.4 6022.1 6086.8 6141.0 6145.6 6161.2 10072.4 10133.9 10154.3 10205.4 10222.4 8521.4 9725.4 10065.9 10068.5 10119.6 7906.1 7928.6 7937.8 7996.2 7999.3 7830.2 7848.9 7909.5 7915.0 7918.4 8989.5 9138.0 9172.7 9196.2 9237.3 9314.4 9485.6 9486.4 9618.1 9667.0 7477.7 7524.2 7534.2 7537.4 7550.4 8006.1 8087.6 8133.6 8156.4 8168.3 7541.7 7609.9 7615.0 7616.7 7701.6 7415.0 7448.2 7531.8 7539.8 7641.8 6424.7 6736.1 7325.9 7410.8 7540.5 6784.3 6862.5 6868.3 6874.0 6879.0 6167.1 6842.3 6895.0 6904.6 6916.4 16:35:58 INFO - 2015-11-20 16:35:58,741 DEBUG : BROWSER_OUTPUT: 16:35:58 INFO - 2015-11-20 16:35:58,741 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6075.99 Median:7026.94 stddev:2033.57 (28.9%) stddev-sans-first:1992.32 16:35:58 INFO - 2015-11-20 16:35:58,742 DEBUG : BROWSER_OUTPUT: Values: 287.3 322.8 326.3 331.6 332.9 5994.8 6236.5 7009.6 7051.4 7083.4 6816.6 6958.8 6990.0 7044.3 7056.4 5156.5 5163.4 5177.9 5188.0 5198.5 3990.0 5157.1 5188.5 5194.6 5213.8 4372.9 4913.7 4945.7 4971.6 4983.4 4669.9 4940.0 4984.8 4990.4 5005.8 3534.2 4165.3 4173.3 4204.7 4246.6 6705.1 6709.8 6726.5 6771.5 6774.3 4895.5 5914.0 5941.3 5981.3 5997.4 7235.9 7458.7 7462.9 7479.9 7485.1 4760.5 4768.9 4769.8 4779.3 4780.8 7844.5 7906.2 7918.0 7924.4 7932.7 3953.9 3979.3 4194.0 4619.3 4832.5 4054.5 4343.8 4868.5 4927.9 4934.7 5923.7 5938.1 5949.1 5986.0 5990.9 6419.0 6494.3 7537.0 7580.1 7643.7 1561.4 1645.7 1649.9 1718.2 1719.3 959.8 1037.2 1090.2 1095.0 1097.4 5733.6 7072.6 7075.3 7096.2 7127.5 7822.1 7823.8 7869.3 7872.6 7884.8 5778.4 6931.8 7071.5 7081.3 7215.6 4051.1 4103.3 4110.1 4160.7 4195.4 8105.2 8133.0 8151.5 8157.5 8180.4 6560.6 7876.2 8108.2 8131.6 8140.3 7323.1 7546.7 8122.6 8141.3 8153.2 7884.6 7904.6 7917.9 7940.2 7943.8 7527.7 7746.7 7749.5 7754.8 7778.3 8121.1 8138.5 8145.3 8161.7 8179.1 4847.2 4857.0 4883.7 4888.4 4905.0 7654.8 7895.3 7928.7 7929.3 7933.8 7623.6 7658.3 7658.5 7673.9 7689.8 7381.2 7531.1 7593.1 7613.9 7614.9 7343.8 7390.6 7396.0 7397.8 7399.4 7548.1 7561.2 7573.5 7590.4 7618.3 7207.4 7438.5 7452.2 7465.4 7490.5 16:35:58 INFO - 2015-11-20 16:35:58,742 DEBUG : BROWSER_OUTPUT: 16:35:58 INFO - 2015-11-20 16:35:58,742 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:19038.97 Median:535.61 stddev:27349.87 (5106.3%) stddev-sans-first:27392.03 16:35:58 INFO - 2015-11-20 16:35:58,744 DEBUG : BROWSER_OUTPUT: Values: 725.4 808.2 815.9 835.4 860.7 12615.6 12889.4 12929.4 12961.8 13010.7 14172.1 14262.1 14262.2 14270.6 14304.6 746.9 765.0 928.2 944.8 945.1 873.9 916.6 927.9 942.1 945.9 992.5 1003.8 1009.8 1011.3 1012.8 984.1 987.4 995.8 999.8 1005.0 608.8 706.2 735.5 738.2 751.4 14745.1 14924.4 14954.0 14988.6 15102.1 11907.2 12274.0 12564.8 12606.7 12779.0 10171.1 10279.4 10406.6 10672.8 10953.4 3466.3 3579.6 3587.1 3593.3 3624.9 66963.3 80084.2 81928.0 81933.0 82085.0 9684.3 9827.7 9877.3 9917.9 10469.4 21271.4 21499.0 21505.9 21544.7 21740.5 7359.4 7424.7 7597.4 7649.5 7775.3 4065.8 4152.8 4226.1 4260.1 4270.5 3458.5 3519.2 3521.3 3524.9 3527.8 623.8 632.9 636.4 654.0 658.9 504.7 508.1 524.7 531.1 534.2 8665.4 8741.1 8755.7 8769.7 8927.9 493.1 493.4 495.5 537.0 541.9 4027.8 4140.5 4150.3 4239.3 4267.6 94769.0 96190.0 97014.0 97043.5 100767.0 67902.7 86710.6 87950.6 88716.6 88806.1 76967.6 77620.0 77815.0 77870.8 79288.0 8282.2 8336.7 8478.5 8527.7 8589.0 51933.4 52619.7 53017.5 53292.5 54242.7 73134.3 73508.6 73519.6 77230.0 78074.6 10996.1 11100.2 11364.4 11503.8 11824.0 12044.9 12079.3 12087.2 12088.5 12237.4 11482.8 11954.9 12020.6 12068.0 12353.3 9597.5 9873.0 11157.5 11835.3 11896.9 9356.9 9907.3 10444.4 10897.2 11152.4 9354.9 9512.2 9532.2 9905.2 10086.4 9016.6 9399.0 9789.5 9835.9 9937.9 16:35:58 INFO - 2015-11-20 16:35:58,744 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:35:58 INFO - 2015-11-20 16:35:58,744 DEBUG : BROWSER_OUTPUT: 16:35:59 INFO - 2015-11-20 16:35:59,144 INFO : Browser exited with error code: 0 16:35:59 INFO - 2015-11-20 16:35:59,169 INFO : Completed test dromaeo_css (00:18:30) 16:35:59 INFO - 2015-11-20 16:35:59,169 INFO : Starting test kraken 16:35:59 INFO - 2015-11-20 16:35:59,169 DEBUG : operating with platform_type : mac_ 16:35:59 INFO - 2015-11-20 16:35:59,169 INFO : Initialising browser for kraken test... 16:35:59 INFO - 2015-11-20 16:35:59,182 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpzVD_iw/profile http://localhost:50925/getInfo.html 16:36:01 INFO - 2015-11-20 16:36:01,847 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:36:01 INFO - 2015-11-20 16:36:01,847 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:36:01 INFO - 2015-11-20 16:36:01,847 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:36:01 INFO - 2015-11-20 16:36:01,848 DEBUG : BROWSER_OUTPUT: __metrics 16:36:02 INFO - 2015-11-20 16:36:02,540 INFO : Browser initialized. 16:36:02 INFO - 2015-11-20 16:36:02,541 INFO : Running cycle 1/1 for kraken test... 16:36:02 INFO - 2015-11-20 16:36:02,541 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpzVD_iw/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:36:14 INFO - 2015-11-20 16:36:14,374 DEBUG : BROWSER_OUTPUT: RSS: Main: 236277760 16:36:14 INFO - 2015-11-20 16:36:14,374 DEBUG : BROWSER_OUTPUT: 16:36:17 INFO - 2015-11-20 16:36:17,426 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50925/tests/kraken/driver.html?testName=audio-beat-detection) 16:36:18 INFO - 2015-11-20 16:36:18,043 DEBUG : BROWSER_OUTPUT: RSS: Main: 248487936 16:36:18 INFO - 2015-11-20 16:36:18,044 DEBUG : BROWSER_OUTPUT: 16:36:20 INFO - 2015-11-20 16:36:20,710 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50925/tests/kraken/driver.html?testName=audio-dft) 16:36:21 INFO - 2015-11-20 16:36:21,308 DEBUG : BROWSER_OUTPUT: RSS: Main: 258764800 16:36:21 INFO - 2015-11-20 16:36:21,309 DEBUG : BROWSER_OUTPUT: 16:36:24 INFO - 2015-11-20 16:36:24,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50925/tests/kraken/driver.html?testName=audio-fft) 16:36:25 INFO - 2015-11-20 16:36:25,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 261357568 16:36:25 INFO - 2015-11-20 16:36:25,057 DEBUG : BROWSER_OUTPUT: 16:36:26 INFO - 2015-11-20 16:36:26,851 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50925/tests/kraken/driver.html?testName=audio-oscillator) 16:36:27 INFO - 2015-11-20 16:36:27,439 DEBUG : BROWSER_OUTPUT: RSS: Main: 262041600 16:36:27 INFO - 2015-11-20 16:36:27,440 DEBUG : BROWSER_OUTPUT: 16:36:29 INFO - 2015-11-20 16:36:29,542 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50925/tests/kraken/driver.html?testName=imaging-gaussian-blur) 16:36:30 INFO - 2015-11-20 16:36:30,122 DEBUG : BROWSER_OUTPUT: RSS: Main: 262742016 16:36:30 INFO - 2015-11-20 16:36:30,122 DEBUG : BROWSER_OUTPUT: 16:36:32 INFO - 2015-11-20 16:36:32,832 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50925/tests/kraken/driver.html?testName=imaging-darkroom) 16:36:33 INFO - 2015-11-20 16:36:33,432 DEBUG : BROWSER_OUTPUT: RSS: Main: 264622080 16:36:33 INFO - 2015-11-20 16:36:33,432 DEBUG : BROWSER_OUTPUT: 16:36:36 INFO - 2015-11-20 16:36:36,287 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50925/tests/kraken/driver.html?testName=imaging-desaturate) 16:36:36 INFO - 2015-11-20 16:36:36,873 DEBUG : BROWSER_OUTPUT: RSS: Main: 262623232 16:36:36 INFO - 2015-11-20 16:36:36,873 DEBUG : BROWSER_OUTPUT: 16:36:39 INFO - 2015-11-20 16:36:39,928 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50925/tests/kraken/driver.html?testName=json-parse-financial) 16:36:40 INFO - 2015-11-20 16:36:40,528 DEBUG : BROWSER_OUTPUT: RSS: Main: 263299072 16:36:40 INFO - 2015-11-20 16:36:40,528 DEBUG : BROWSER_OUTPUT: 16:36:42 INFO - 2015-11-20 16:36:42,043 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50925/tests/kraken/driver.html?testName=json-stringify-tinderbox) 16:36:42 INFO - 2015-11-20 16:36:42,629 DEBUG : BROWSER_OUTPUT: RSS: Main: 263503872 16:36:42 INFO - 2015-11-20 16:36:42,629 DEBUG : BROWSER_OUTPUT: 16:36:44 INFO - 2015-11-20 16:36:44,392 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50925/tests/kraken/driver.html?testName=stanford-crypto-aes) 16:36:45 INFO - 2015-11-20 16:36:45,022 DEBUG : BROWSER_OUTPUT: RSS: Main: 264241152 16:36:45 INFO - 2015-11-20 16:36:45,022 DEBUG : BROWSER_OUTPUT: 16:36:47 INFO - 2015-11-20 16:36:47,206 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50925/tests/kraken/driver.html?testName=stanford-crypto-ccm) 16:36:47 INFO - 2015-11-20 16:36:47,811 DEBUG : BROWSER_OUTPUT: RSS: Main: 264376320 16:36:47 INFO - 2015-11-20 16:36:47,811 DEBUG : BROWSER_OUTPUT: 16:36:50 INFO - 2015-11-20 16:36:50,334 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 16:36:50 INFO - 2015-11-20 16:36:50,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 264134656 16:36:50 INFO - 2015-11-20 16:36:50,937 DEBUG : BROWSER_OUTPUT: 16:36:53 INFO - 2015-11-20 16:36:53,453 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 16:36:54 INFO - 2015-11-20 16:36:54,055 DEBUG : BROWSER_OUTPUT: RSS: Main: 264728576 16:36:54 INFO - 2015-11-20 16:36:54,055 DEBUG : BROWSER_OUTPUT: 16:36:55 INFO - 2015-11-20 16:36:55,808 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50925/tests/kraken/driver.html?testName=ai-astar) 16:36:56 INFO - 2015-11-20 16:36:56,065 DEBUG : BROWSER_OUTPUT: RSS: Main: 264085504 16:36:56 INFO - 2015-11-20 16:36:56,066 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,066 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:36:56 INFO - 2015-11-20 16:36:56,066 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:36:56 INFO - 2015-11-20 16:36:56,067 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:36:56 INFO - 2015-11-20 16:36:56,067 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:36:56 INFO - 2015-11-20 16:36:56,067 DEBUG : BROWSER_OUTPUT: |0;ai-astar;115;106;94;166;166;152;115;136;166;166 16:36:56 INFO - 2015-11-20 16:36:56,067 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;147;136;177;183;104;167;128;140;137;141 16:36:56 INFO - 2015-11-20 16:36:56,067 DEBUG : BROWSER_OUTPUT: |2;audio-dft;187;197;190;203;215;197;197;196;186;199 16:36:56 INFO - 2015-11-20 16:36:56,067 DEBUG : BROWSER_OUTPUT: |3;audio-fft;60;62;72;122;56;60;57;59;89;56 16:36:56 INFO - 2015-11-20 16:36:56,067 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;76;81;125;60;111;112;110;88;111;94 16:36:56 INFO - 2015-11-20 16:36:56,068 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;87;100;125;87;88;87;88;89;88;88 16:36:56 INFO - 2015-11-20 16:36:56,068 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;98;96;107;142;123;95;94;94;96;96 16:36:56 INFO - 2015-11-20 16:36:56,068 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;77;77;148;76;142;107;125;143;147;91 16:36:56 INFO - 2015-11-20 16:36:56,068 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;60;59;58;59;57;59;66;58;57 16:36:56 INFO - 2015-11-20 16:36:56,068 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;67;70;66;66;68;68;70;70;71 16:36:56 INFO - 2015-11-20 16:36:56,068 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;75;79;93;103;111;109;111;95;84;86 16:36:56 INFO - 2015-11-20 16:36:56,068 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;124;133;129;130;124;132;131;124;133;132 16:36:56 INFO - 2015-11-20 16:36:56,068 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;145;150;149;140;141;146;139;127;165;178 16:36:56 INFO - 2015-11-20 16:36:56,068 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;69;66;65;67;64;70;97;92;94;97 16:36:56 INFO - 2015-11-20 16:36:56,068 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:36:56 INFO - 2015-11-20 16:36:56,068 DEBUG : BROWSER_OUTPUT: __start_cc_report 16:36:56 INFO - 2015-11-20 16:36:56,068 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,813 16:36:56 INFO - 2015-11-20 16:36:56,068 DEBUG : BROWSER_OUTPUT: __end_cc_report 16:36:56 INFO - 2015-11-20 16:36:56,069 DEBUG : BROWSER_OUTPUT: __startTimestamp1448066216065__endTimestamp 16:36:56 INFO - 2015-11-20 16:36:56,069 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,070 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:36:56 INFO - 2015-11-20 16:36:56,070 DEBUG : BROWSER_OUTPUT: Number of tests: 14 16:36:56 INFO - 2015-11-20 16:36:56,071 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,071 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:138.20 Median:166.00 stddev:28.58 (17.2%) stddev-sans-first:29.06 16:36:56 INFO - 2015-11-20 16:36:56,071 DEBUG : BROWSER_OUTPUT: Values: 115.0 106.0 94.0 166.0 166.0 152.0 115.0 136.0 166.0 166.0 16:36:56 INFO - 2015-11-20 16:36:56,071 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,071 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:146.00 Median:144.00 stddev:23.81 (16.5%) stddev-sans-first:25.25 16:36:56 INFO - 2015-11-20 16:36:56,071 DEBUG : BROWSER_OUTPUT: Values: 147.0 136.0 177.0 183.0 104.0 167.0 128.0 140.0 137.0 141.0 16:36:56 INFO - 2015-11-20 16:36:56,071 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,071 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:196.70 Median:197.00 stddev:8.39 (4.3%) stddev-sans-first:8.14 16:36:56 INFO - 2015-11-20 16:36:56,072 DEBUG : BROWSER_OUTPUT: Values: 187.0 197.0 190.0 203.0 215.0 197.0 197.0 196.0 186.0 199.0 16:36:56 INFO - 2015-11-20 16:36:56,072 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,072 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:69.30 Median:60.00 stddev:21.11 (35.2%) stddev-sans-first:22.12 16:36:56 INFO - 2015-11-20 16:36:56,072 DEBUG : BROWSER_OUTPUT: Values: 60.0 62.0 72.0 122.0 56.0 60.0 57.0 59.0 89.0 56.0 16:36:56 INFO - 2015-11-20 16:36:56,072 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,072 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:96.80 Median:68.00 stddev:20.35 (29.9%) stddev-sans-first:20.14 16:36:56 INFO - 2015-11-20 16:36:56,072 DEBUG : BROWSER_OUTPUT: Values: 76.0 81.0 125.0 60.0 111.0 112.0 110.0 88.0 111.0 94.0 16:36:56 INFO - 2015-11-20 16:36:56,072 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,072 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:92.70 Median:88.00 stddev:12.00 (13.6%) stddev-sans-first:12.55 16:36:56 INFO - 2015-11-20 16:36:56,072 DEBUG : BROWSER_OUTPUT: Values: 87.0 100.0 125.0 87.0 88.0 87.0 88.0 89.0 88.0 88.0 16:36:56 INFO - 2015-11-20 16:36:56,072 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,072 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:104.10 Median:95.50 stddev:16.07 (16.8%) stddev-sans-first:16.89 16:36:56 INFO - 2015-11-20 16:36:56,073 DEBUG : BROWSER_OUTPUT: Values: 98.0 96.0 107.0 142.0 123.0 95.0 94.0 94.0 96.0 96.0 16:36:56 INFO - 2015-11-20 16:36:56,073 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,073 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:113.30 Median:112.00 stddev:31.17 (27.8%) stddev-sans-first:30.17 16:36:56 INFO - 2015-11-20 16:36:56,073 DEBUG : BROWSER_OUTPUT: Values: 77.0 77.0 148.0 76.0 142.0 107.0 125.0 143.0 147.0 91.0 16:36:56 INFO - 2015-11-20 16:36:56,073 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,073 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.20 Median:59.00 stddev:2.57 (4.4%) stddev-sans-first:2.73 16:36:56 INFO - 2015-11-20 16:36:56,074 DEBUG : BROWSER_OUTPUT: Values: 59.0 60.0 59.0 58.0 59.0 57.0 59.0 66.0 58.0 57.0 16:36:56 INFO - 2015-11-20 16:36:56,074 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,074 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.30 Median:69.00 stddev:1.83 (2.7%) stddev-sans-first:1.88 16:36:56 INFO - 2015-11-20 16:36:56,074 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 70.0 66.0 66.0 68.0 68.0 70.0 70.0 71.0 16:36:56 INFO - 2015-11-20 16:36:56,074 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,075 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:94.60 Median:81.50 stddev:13.47 (16.5%) stddev-sans-first:12.28 16:36:56 INFO - 2015-11-20 16:36:56,075 DEBUG : BROWSER_OUTPUT: Values: 75.0 79.0 93.0 103.0 111.0 109.0 111.0 95.0 84.0 86.0 16:36:56 INFO - 2015-11-20 16:36:56,075 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,075 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:129.20 Median:131.50 stddev:3.79 (2.9%) stddev-sans-first:3.53 16:36:56 INFO - 2015-11-20 16:36:56,075 DEBUG : BROWSER_OUTPUT: Values: 124.0 133.0 129.0 130.0 124.0 132.0 131.0 124.0 133.0 132.0 16:36:56 INFO - 2015-11-20 16:36:56,075 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,075 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:148.00 Median:147.50 stddev:14.31 (9.7%) stddev-sans-first:15.13 16:36:56 INFO - 2015-11-20 16:36:56,075 DEBUG : BROWSER_OUTPUT: Values: 145.0 150.0 149.0 140.0 141.0 146.0 139.0 127.0 165.0 178.0 16:36:56 INFO - 2015-11-20 16:36:56,075 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,075 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:78.10 Median:81.00 stddev:14.72 (18.2%) stddev-sans-first:15.24 16:36:56 INFO - 2015-11-20 16:36:56,075 DEBUG : BROWSER_OUTPUT: Values: 69.0 66.0 65.0 67.0 64.0 70.0 97.0 92.0 94.0 97.0 16:36:56 INFO - 2015-11-20 16:36:56,075 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:36:56 INFO - 2015-11-20 16:36:56,075 DEBUG : BROWSER_OUTPUT: 16:36:56 INFO - 2015-11-20 16:36:56,669 INFO : Browser exited with error code: 0 16:36:56 INFO - 2015-11-20 16:36:56,715 INFO : Completed test kraken (00:00:57) 16:36:56 INFO - 2015-11-20 16:36:56,715 INFO : Starting test v8_7 16:36:56 INFO - 2015-11-20 16:36:56,715 DEBUG : operating with platform_type : mac_ 16:36:56 INFO - 2015-11-20 16:36:56,716 INFO : Initialising browser for v8_7 test... 16:36:56 INFO - 2015-11-20 16:36:56,728 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpON4REZ/profile http://localhost:50925/getInfo.html 16:36:59 INFO - 2015-11-20 16:36:59,405 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 16:36:59 INFO - 2015-11-20 16:36:59,405 DEBUG : BROWSER_OUTPUT: colorDepth:24 16:36:59 INFO - 2015-11-20 16:36:59,405 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 16:36:59 INFO - 2015-11-20 16:36:59,405 DEBUG : BROWSER_OUTPUT: __metrics 16:37:00 INFO - 2015-11-20 16:37:00,021 INFO : Browser initialized. 16:37:00 INFO - 2015-11-20 16:37:00,022 INFO : Running cycle 1/1 for v8_7 test... 16:37:00 INFO - 2015-11-20 16:37:00,022 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/T/tmpON4REZ/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 16:37:11 INFO - 2015-11-20 16:37:11,970 DEBUG : BROWSER_OUTPUT: RSS: Main: 236175360 16:37:11 INFO - 2015-11-20 16:37:11,970 DEBUG : BROWSER_OUTPUT: 16:37:33 INFO - 2015-11-20 16:37:33,417 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50925/tests/v8_7/run.html (next: http://localhost:50925/tests/v8_7/run.html) 16:37:33 INFO - 2015-11-20 16:37:33,680 DEBUG : BROWSER_OUTPUT: RSS: Main: 247738368 16:37:33 INFO - 2015-11-20 16:37:33,680 DEBUG : BROWSER_OUTPUT: 16:37:33 INFO - 2015-11-20 16:37:33,680 DEBUG : BROWSER_OUTPUT: __start_tp_report 16:37:33 INFO - 2015-11-20 16:37:33,681 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 16:37:33 INFO - 2015-11-20 16:37:33,681 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 16:37:33 INFO - 2015-11-20 16:37:33,681 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 16:37:33 INFO - 2015-11-20 16:37:33,681 DEBUG : BROWSER_OUTPUT: |0;Richards;148.65467518953471 16:37:33 INFO - 2015-11-20 16:37:33,681 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;158.07777426493834 16:37:33 INFO - 2015-11-20 16:37:33,681 DEBUG : BROWSER_OUTPUT: |2;Encrypt;283.36639274582035 16:37:33 INFO - 2015-11-20 16:37:33,681 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4960.39603960396 16:37:33 INFO - 2015-11-20 16:37:33,681 DEBUG : BROWSER_OUTPUT: |4;RayTrace;948.7666034155598 16:37:33 INFO - 2015-11-20 16:37:33,681 DEBUG : BROWSER_OUTPUT: |5;Earley;843.1703204047218 16:37:33 INFO - 2015-11-20 16:37:33,681 DEBUG : BROWSER_OUTPUT: |6;Boyer;12662.5 16:37:33 INFO - 2015-11-20 16:37:33,681 DEBUG : BROWSER_OUTPUT: |7;RegExp;26894.736842105263 16:37:33 INFO - 2015-11-20 16:37:33,681 DEBUG : BROWSER_OUTPUT: |8;Splay;1567.398119122257 16:37:33 INFO - 2015-11-20 16:37:33,681 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4513.513513513513 16:37:33 INFO - 2015-11-20 16:37:33,682 DEBUG : BROWSER_OUTPUT: __end_tp_report 16:37:33 INFO - 2015-11-20 16:37:33,682 DEBUG : BROWSER_OUTPUT: __startTimestamp1448066253677__endTimestamp 16:37:33 INFO - 2015-11-20 16:37:33,682 DEBUG : BROWSER_OUTPUT: 16:37:33 INFO - 2015-11-20 16:37:33,682 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 16:37:33 INFO - 2015-11-20 16:37:33,682 DEBUG : BROWSER_OUTPUT: Number of tests: 10 16:37:33 INFO - 2015-11-20 16:37:33,682 DEBUG : BROWSER_OUTPUT: 16:37:33 INFO - 2015-11-20 16:37:33,682 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:148.65 Median:148.65 stddev:0.00 (0.0%) 16:37:33 INFO - 2015-11-20 16:37:33,682 DEBUG : BROWSER_OUTPUT: Values: 148.7 16:37:33 INFO - 2015-11-20 16:37:33,682 DEBUG : BROWSER_OUTPUT: 16:37:33 INFO - 2015-11-20 16:37:33,682 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:158.08 Median:158.08 stddev:0.00 (0.0%) 16:37:33 INFO - 2015-11-20 16:37:33,682 DEBUG : BROWSER_OUTPUT: Values: 158.1 16:37:33 INFO - 2015-11-20 16:37:33,682 DEBUG : BROWSER_OUTPUT: 16:37:33 INFO - 2015-11-20 16:37:33,682 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:283.37 Median:283.37 stddev:0.00 (0.0%) 16:37:33 INFO - 2015-11-20 16:37:33,683 DEBUG : BROWSER_OUTPUT: Values: 283.4 16:37:33 INFO - 2015-11-20 16:37:33,683 DEBUG : BROWSER_OUTPUT: 16:37:33 INFO - 2015-11-20 16:37:33,683 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4960.40 Median:4960.40 stddev:0.00 (0.0%) 16:37:33 INFO - 2015-11-20 16:37:33,683 DEBUG : BROWSER_OUTPUT: Values: 4960.4 16:37:33 INFO - 2015-11-20 16:37:33,683 DEBUG : BROWSER_OUTPUT: 16:37:33 INFO - 2015-11-20 16:37:33,683 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:948.77 Median:948.77 stddev:0.00 (0.0%) 16:37:33 INFO - 2015-11-20 16:37:33,683 DEBUG : BROWSER_OUTPUT: Values: 948.8 16:37:33 INFO - 2015-11-20 16:37:33,683 DEBUG : BROWSER_OUTPUT: 16:37:33 INFO - 2015-11-20 16:37:33,683 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:843.17 Median:843.17 stddev:0.00 (0.0%) 16:37:33 INFO - 2015-11-20 16:37:33,683 DEBUG : BROWSER_OUTPUT: Values: 843.2 16:37:33 INFO - 2015-11-20 16:37:33,683 DEBUG : BROWSER_OUTPUT: 16:37:33 INFO - 2015-11-20 16:37:33,683 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12662.50 Median:12662.50 stddev:0.00 (0.0%) 16:37:33 INFO - 2015-11-20 16:37:33,683 DEBUG : BROWSER_OUTPUT: Values: 12662.5 16:37:33 INFO - 2015-11-20 16:37:33,684 DEBUG : BROWSER_OUTPUT: 16:37:33 INFO - 2015-11-20 16:37:33,684 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26894.74 Median:26894.74 stddev:0.00 (0.0%) 16:37:33 INFO - 2015-11-20 16:37:33,684 DEBUG : BROWSER_OUTPUT: Values: 26894.7 16:37:33 INFO - 2015-11-20 16:37:33,684 DEBUG : BROWSER_OUTPUT: 16:37:33 INFO - 2015-11-20 16:37:33,684 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:1567.40 Median:1567.40 stddev:0.00 (0.0%) 16:37:33 INFO - 2015-11-20 16:37:33,684 DEBUG : BROWSER_OUTPUT: Values: 1567.4 16:37:33 INFO - 2015-11-20 16:37:33,684 DEBUG : BROWSER_OUTPUT: 16:37:33 INFO - 2015-11-20 16:37:33,684 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4513.51 Median:4513.51 stddev:0.00 (0.0%) 16:37:33 INFO - 2015-11-20 16:37:33,684 DEBUG : BROWSER_OUTPUT: Values: 4513.5 16:37:33 INFO - 2015-11-20 16:37:33,684 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 16:37:33 INFO - 2015-11-20 16:37:33,684 DEBUG : BROWSER_OUTPUT: 16:37:34 INFO - 2015-11-20 16:37:34,341 INFO : Browser exited with error code: 0 16:37:34 INFO - 2015-11-20 16:37:34,359 INFO : Completed test v8_7 (00:00:37) 16:37:34 INFO - 2015-11-20 16:37:34,743 INFO : Completed test suite (00:20:05) 16:37:34 INFO - 2015-11-20 16:37:34,744 DEBUG : Working with test: dromaeo_css 16:37:34 INFO - 2015-11-20 16:37:34,744 DEBUG : Generating results file: dromaeo_css 16:37:34 INFO - 2015-11-20 16:37:34,745 DEBUG : Working with test: kraken 16:37:34 INFO - 2015-11-20 16:37:34,745 DEBUG : Generating results file: kraken 16:37:34 INFO - 2015-11-20 16:37:34,745 INFO : javascript benchmark 16:37:34 INFO - 2015-11-20 16:37:34,745 DEBUG : Working with test: v8_7 16:37:34 INFO - 2015-11-20 16:37:34,745 DEBUG : Generating results file: v8_7 16:37:34 INFO - 2015-11-20 16:37:34,745 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:37:35 INFO - 2015-11-20 16:37:35,235 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 16:37:35 INFO - 2015-11-20 16:37:35,236 DEBUG : process_Request line: dromaeo_css 7659.38 graph.html#tests=[[72,64,61]] 16:37:35 INFO - 2015-11-20 16:37:35,236 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:37:35 INFO - 2015-11-20 16:37:35,262 DEBUG : process_Request line: kraken 1534.50 graph.html#tests=[[232,64,61]] 16:37:35 INFO - 2015-11-20 16:37:35,262 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 16:37:35 INFO - 2015-11-20 16:37:35,291 DEBUG : process_Request line: v8_7 19927.59 graph.html#tests=[[230,64,61]] 16:37:35 INFO - 2015-11-20 16:37:35,291 INFO : javascript benchmark 16:37:35 INFO - 2015-11-20 16:37:35,293 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3273.836308184591, 3509.1402606361444, 3523.3305671922317, 3544.0431083607427, 3550.6804387605125, 4640.67515273931, 5728.656280623166, 5855.970720146399, 5929.673867937262, 5946.4945479634225, 5873.353931067579, 5878.441548052939, 5995.880082398349, 6026.216591843055, 6064.727087281072, 5297.973510132444, 5346.304980352549, 5354.544863686591, 5435.239066530669, 5451.373092094401, 4517.570830771071, 5410.0, 5430.8913821723545, 5446.373667028302, 5466.070767969455, 5150.896982060375, 5206.609504287175, 5283.55089817366, 5287.920681189786, 5316.574674026068, 5287.021900948298, 5289.444608316148, 5309.044372013036, 5349.946500534984, 5353.678779273256, 5148.9742551287, 5282.128448805943, 5311.362636483646, 5335.279737235463, 5365.651232669864, 4496.3705081288645, 5348.946510534884, 5630.5495560355075, 5797.768089276466, 5822.883542329172, 6326.240851097898, 6355.5551111421755, 6356.173697419306, 6369.140166077566, 6393.520485963525, 6191.659458729768, 6309.580344422468, 6362.300146983828, 6407.807765766988, 6414.967925160391, 5916.408359164092, 5993.9700301498215, 6012.579119461596, 6014.879702405928, 6075.665838378932, 6376.011718183689, 6454.451371633464, 6478.740850365933, 6513.837154071091, 6527.34726527353, 5965.880682386415, 6150.7232174552255, 6214.285357183981, 6315.210598675166, 6328.493720502441, 6373.6175829450385, 6391.808245752635, 6400.551961362753, 6413.551051426355, 6416.326285740023, 6323.873522529616, 6326.746930122744, 6334.398232167937, 6335.68321583919, 6338.524610654219, 6147.877042459215, 6154.430430350386, 6279.246490421087, 6304.432601065926, 6323.494120470351, 4939.036887806843, 4939.802407903716, 4949.529794669501, 4960.131976904027, 5100.464451232567, 4440.045390241114, 4454.7549884756, 4474.194644963938, 4477.104579084131, 4478.932816007762, 5838.591298609142, 5840.182374467578, 5933.2286802716235, 5990.191324171181, 6058.666773327509, 6340.685649737905, 6356.713947872357, 6362.236531616143, 6362.522810789209, 6394.680265986682, 5794.1308803679785, 6054.243219597551, 6072.969635151796, 6087.0, 6104.389561043949, 5456.127019676833, 5494.230807686927, 5531.889362212733, 5546.445355464502, 5579.218909352694, 6455.870222711101, 6470.514711396664, 6506.41442270198, 6523.151990241333, 6551.017347397833, 6157.476614487819, 6217.036359364306, 6306.558540902276, 6311.337309582428, 6324.905126423199, 6311.211098612674, 6339.461145802658, 6382.457491113308, 6393.264774550986, 6404.391582799627, 6247.468965138014, 6281.183446151971, 6292.590981586182, 6300.9684951574945, 6302.779402720883, 6132.4166970161305, 6139.26328840542, 6245.718942647501, 6340.9365906340345, 6360.077788720702, 6234.657093859882, 6248.156498872594, 6255.124282600348, 6262.624242545462, 6264.279607844974, 6084.939150608438, 6215.378462153749, 6233.065040244, 6234.314225435289, 6252.843678908063, 5006.674566153189, 5973.462388385066, 5983.9401605983385, 6021.187139736079, 6168.228971378578, 6257.874842503215, 6289.779857704958, 6298.496120310456, 6303.810885673437, 6340.365963403623, 5091.007253585663, 6227.657478838707, 6227.9377206227355, 6229.470495007975, 6233.252009758677], "unit": "ms", "name": "dojo.html", "value": 5801.1699807115165}, {"lowerIsBetter": false, "replicates": [558.7764894042385, 580.7676929228311, 584.2171490203128, 584.9587733833774, 590.9481123599993, 42043.57956420435, 42803.785981070054, 42903.570964290346, 43048.78475607622, 43087.78456107719, 45623.087538249216, 45864.54135458644, 45923.0, 46128.53871461293, 46150.7692461538, 9842.655507057272, 9955.701328960144, 10013.349132306414, 10041.899581004169, 10067.0, 9846.507674616276, 9917.801643967116, 9961.35251208669, 9968.003199680046, 9983.40099594023, 9830.115289623933, 9864.260180486457, 9878.60485580576, 9895.208383329353, 9905.950470247639, 9861.506924653775, 9908.801823963517, 9958.103770660675, 9971.501424928798, 9983.351082179672, 9757.170640495495, 9864.704058878173, 9913.256505762096, 9916.355436896578, 9929.65246216379, 42260.57739422597, 42324.576754232374, 42399.57600423987, 42641.78679106616, 42792.0, 2809.1712944681367, 3225.193701574606, 3278.327942771726, 3387.7459190560808, 3457.550518432613, 28798.712012879812, 29600.70399296001, 29706.851465742748, 29712.702872971426, 29940.0, 2795.5247607906704, 2802.047303916678, 2835.4045650413436, 2873.094975082863, 2996.6104406427244, 489665.0, 490695.0, 493394.0, 494529.0, 494789.0, 46595.5340446598, 47098.0, 47123.29315060277, 47251.0, 47254.81862953454, 46470.53529464662, 46561.767191163824, 46589.06821863544, 46784.7660761694, 46785.76607117011, 15640.687186256211, 15739.976901501366, 15744.685106298039, 15749.370025199092, 15791.131487768052, 12485.50057997688, 12513.624591262276, 12660.17708848922, 12723.936380318039, 12945.741085178432, 15307.846921530865, 15317.6170595736, 15318.702194670888, 15333.31000104998, 15463.38146474151, 6156.6921653918025, 6189.885820552254, 6622.37087476689, 6663.167104111986, 6684.231313398924, 831.9708810191614, 959.712086374085, 1031.6079889641887, 1117.5473933057124, 1210.673118258083, 33555.328893421996, 33813.323733525685, 34051.14872128167, 34206.82896585501, 34236.31527369488, 1073.4847273308856, 1088.8257878739523, 1092.1972350322508, 1098.8132017557034, 1210.5036934856666, 14850.92574537142, 15721.528354149394, 17148.31406743741, 17348.65302693939, 17459.912700436416, 673501.0, 683029.0, 692917.0, 699809.0, 703728.0, 63432.0, 63796.0, 64249.67875160594, 64479.03281450782, 64594.67702661551, 1411.089847048648, 1438.280859570215, 1451.9419223231164, 1456.3155317000992, 1605.9320551833134, 31296.530552042193, 31392.215194620316, 31551.55275159482, 31567.0, 32023.199420014687, 52773.7361313191, 52798.68003299948, 53249.20126198033, 53249.733751331, 53291.0, 509857.0, 511298.0, 512737.0, 513453.0, 516925.0, 32962.17594560155, 33700.32599348048, 33792.324153517286, 34093.613447058466, 34288.0, 45369.0, 46138.0, 46413.0, 46571.53428465672, 46820.29769553391, 37076.70231541883, 38866.61133388743, 40917.59082409257, 41332.58667413408, 42886.92782680458, 38361.040973975876, 39113.0, 39204.41193382159, 39315.0, 41186.588134118276, 37547.81226093852, 38325.808370957966, 38345.041373964756, 38545.61454385532, 38796.61203388043, 32891.50662740109, 34228.828855856555, 34367.48448773321, 34546.30907381788, 34666.9599912003, 21608.567828643652, 26213.0, 27294.0, 27603.72396276092, 28662.713372866005], "unit": "ms", "name": "ext.html", "value": 20109.99067067808}, {"lowerIsBetter": false, "replicates": [357.20521838908434, 363.81445462813963, 366.13409287036166, 366.27477594363154, 366.28208710926583, 16106.758398624, 19562.0, 20759.273425430096, 21253.468663283387, 21485.57028859422, 11703.53185872564, 15351.923240383783, 18540.44378668642, 18852.62294754104, 19819.60360792783, 4500.482444518873, 4561.749103799298, 5227.921581176285, 5458.181272809071, 5630.971845140769, 4748.97625511872, 5577.0, 5638.295213098363, 5659.66042037477, 5665.801696940608, 5365.0, 5453.3728621208675, 5463.672179669213, 5463.945360546403, 5491.066518691832, 5642.576806739511, 5788.913166302509, 5834.6790926499025, 5858.3848695886745, 5878.853028674296, 5593.440655934414, 5613.775448982076, 5641.069223578104, 5648.548116150698, 5653.773849046074, 10791.082757965582, 17008.914955425145, 17119.116897141306, 24383.390415239584, 25415.0, 1984.7915968823354, 2070.6997485364686, 2099.601075795594, 2101.53766171442, 2109.683547467877, 8386.790330241793, 9306.441613503144, 9739.90260097397, 10032.197424206046, 14824.555263342118, 1484.680793629364, 1749.2128542155954, 1795.0, 1824.4982629776785, 1837.1273645018643, 102745.0, 107022.99999999921, 109535.0, 112556.43721781339, 112628.0, 11176.385298808644, 11291.548338066385, 11329.546818127183, 11410.657680269605, 11421.31472111676, 13419.86580134186, 13420.664483387993, 13429.932850335881, 13449.260290684106, 13536.661583460493, 8606.827863442697, 8621.525816080175, 8636.913630863737, 8637.438566493158, 8684.522351270742, 8778.780530486662, 8791.604377803014, 8807.867881981776, 8822.470651760916, 8825.38222324444, 4011.237864805736, 4152.190322887008, 4207.558206388347, 4283.978580107079, 4292.3561465780385, 1621.7405215165518, 1833.8899666020081, 1849.7595312609274, 1888.9338873139375, 1927.0461121744827, 884.5533005832013, 932.7574830543972, 943.2831048403126, 990.8414653655525, 1074.301703892476, 16977.3347313809, 19875.701864472045, 21171.68242476364, 21255.655604065556, 22724.886375568018, 876.3120950054305, 923.8660394242931, 958.726762872578, 965.652365148546, 968.6658102954469, 11099.44502774858, 11339.206255562032, 11472.94263528677, 11490.482928268248, 11502.022328102037, 759055.0, 760640.0, 764932.0, 770785.0, 777464.0, 55713.60715982133, 59830.70084649636, 59959.10061349083, 65326.673366632866, 127879.72120278678, 1022.192467950311, 1105.4693747001324, 1201.069171392178, 1229.4590380232669, 1234.3581337704163, 15301.46444874424, 18887.622247555246, 19162.0, 19372.0, 19373.51566210856, 40558.0, 46249.0, 48106.75946620244, 50345.74827125987, 50908.74545627248, 52478.737606311726, 75985.0, 78943.21056789359, 81093.97265068184, 81720.18279817126, 8597.742067737978, 9860.753481162741, 9906.504674766376, 10111.797764044824, 10156.847647285149, 15629.687406251584, 18710.158042888375, 19218.807811921703, 20055.398338049883, 20158.39524814258, 13354.732905342033, 15408.0, 15440.45958391451, 15672.746180305776, 16008.119553424207, 13339.733205336033, 14888.330025148678, 14985.625359365667, 15496.84503154954, 15971.041737495787, 15825.208739563206, 16286.0, 16542.42101526441, 16568.0, 17038.48884533466, 9385.249180065715, 9584.856227156459, 9692.41845489273, 9736.367136136128, 9751.073648003428, 10284.177265818866, 14370.928145359625, 14840.0, 15340.846591533942, 16612.335506579602], "unit": "ms", "name": "jquery.html", "value": 9708.743365965227}, {"lowerIsBetter": false, "replicates": [1554.549180737586, 1599.3442688497719, 1919.0500702152433, 1964.8329891959183, 1975.950601234968, 7810.336121429671, 7882.842343153148, 8281.13048129946, 8625.396222264437, 8695.73912782616, 8190.303824174952, 8377.204165604273, 8424.410291279597, 8464.788380290496, 8465.49207047576, 2379.345679938018, 2391.80865530758, 2418.4800267942387, 2419.818513611486, 2420.5642984262827, 2422.4791669790993, 2439.85360878347, 2465.864377459239, 2466.7903228225623, 2478.4547399572066, 2396.1972739132325, 2403.5793736096202, 2418.600930846417, 2428.138011006085, 2441.2554170977846, 2380.642903564462, 2399.416385185778, 2405.1461731085474, 2406.568091985266, 2414.6860908081926, 2371.513839662865, 2374.798142157919, 2377.7265614454386, 2382.106709983756, 2382.5711371953043, 8385.916140838575, 8470.534120623362, 8486.363522735819, 8511.319094472488, 8513.53175575343, 4743.810247590092, 5179.249008893689, 5262.473752624745, 5264.263003179558, 5276.182191760245, 2923.4445455363625, 3120.7035331643456, 3495.318412909484, 3504.281622267429, 3563.1626567756557, 1053.6206965492418, 1065.690949624608, 1075.9731006724894, 1092.9289596176222, 1097.4841824342545, 11015.394153321484, 11086.667399978014, 11163.776724465546, 11171.0, 11204.375365572028, 4747.240441529339, 4782.832600858953, 4813.927791083137, 4830.589399901048, 4841.757912104451, 9664.90335096654, 9668.806623867624, 9718.805623887483, 9720.319577629498, 9734.172595329477, 5216.713080780518, 5240.34495688039, 5249.055170069348, 5272.05103081449, 5293.920591191135, 4711.929321060187, 4780.282957556325, 4835.8065677372515, 4841.612670986313, 4863.221884498464, 3340.4488259437408, 3879.3211188042546, 3918.1575961168487, 3928.7249892507252, 3931.0958479549863, 1299.707565797688, 1304.2891624064907, 1312.0880987713447, 1314.8882345000782, 1319.6239071864472, 1339.872712092369, 1347.070521340272, 1362.0329566008245, 1363.2433999130578, 1404.7822587498954, 7813.257740514642, 7875.803104922308, 7924.088729796147, 7928.722494712657, 7941.245581669732, 492.07981075388534, 496.10205527994447, 497.3360563647499, 499.9550040496373, 506.41256142874823, 6022.066579680157, 6086.847828804227, 6140.969295153495, 6145.5698101133385, 6161.229846269216, 10072.446015469219, 10133.898661013296, 10154.289199755945, 10205.438700871524, 10222.386656800616, 8521.403501754941, 9725.416475011521, 10065.899341006496, 10068.546915388824, 10119.595216191417, 7906.090799558009, 7928.643211055516, 7937.801554961056, 7996.160403157584, 7999.280064794197, 7830.177831327628, 7848.921510785048, 7909.485883417559, 7914.960425197837, 7918.406119541172, 8989.505577193317, 9137.954310228406, 9172.724818255463, 9196.172344489029, 9237.307201959746, 9314.394564353295, 9485.573149208165, 9486.430814151174, 9618.086281803218, 9667.033296670277, 7477.663505142173, 7524.247575242432, 7534.246575342422, 7537.434692398202, 7550.433717471102, 8006.079300880473, 8087.595620219083, 8133.552654604054, 8156.429049966446, 8168.346532277523, 7541.660625271986, 7609.885851712118, 7615.0, 7616.657250423855, 7701.614919254127, 7415.0, 7448.1807001228735, 7531.774046778605, 7539.773806785805, 7641.808954776175, 6424.678766061772, 6736.056952026622, 7325.890111648436, 7410.8147296315865, 7540.509866858637, 6784.253732089367, 6862.4853136014, 6868.347506986828, 6873.965630171817, 6879.036934829228, 6167.074938759222, 6842.281560436082, 6895.0, 6904.585724856524, 6916.446684265146], "unit": "ms", "name": "mootools.html", "value": 4737.95880842088}, {"lowerIsBetter": false, "replicates": [287.32192026816693, 322.78857348436776, 326.3179953896356, 331.62195097588744, 332.938406394817, 5994.771071930255, 6236.469900058489, 7009.579425234483, 7051.435885129184, 7083.39791117755, 6816.55692379995, 6958.8260293492685, 6989.965050174755, 7044.295570442953, 7056.400205982485, 5156.53591176794, 5163.406208286039, 5177.87055323618, 5187.962407518493, 5198.45416231296, 3989.9800500997453, 5157.123289040854, 5188.4811518848, 5194.610404219679, 5213.843584692465, 4372.912541749163, 4913.697870064436, 4945.653804233705, 4971.577415919651, 4983.352164218646, 4669.9066018679605, 4939.950600494003, 4984.77568509418, 4990.4261009983775, 5005.774740136666, 3534.1871369584883, 4165.333546632524, 4173.332266837322, 4204.705670603059, 4246.617804397619, 6705.094812200388, 6709.832254193635, 6726.461883049345, 6771.458283337371, 6774.288699686511, 4895.510448955111, 5914.0, 5941.346451890288, 5981.282246130492, 5997.370276120988, 7235.89146162808, 7458.664360103809, 7462.925370746331, 7479.887801682979, 7485.0643669541305, 4760.523947605247, 4768.880777980578, 4769.761511924425, 4779.330893674888, 4780.760961951889, 7844.529328240324, 7906.209379062106, 7917.960410197969, 7924.445288829726, 7932.7223547176145, 3953.9011524712114, 3979.343408337592, 4194.0, 4619.313950408144, 4832.492588278251, 4054.4526488924207, 4343.804528796211, 4868.513148685174, 4927.90144197114, 4934.703917764946, 5923.733431995571, 5938.079597662369, 5949.1076338549565, 5986.0, 5990.850228744229, 6418.967905160444, 6494.318096599884, 7537.0, 7580.128285247157, 7643.656035478417, 1561.3910574875808, 1645.6873194093084, 1649.8762592805347, 1718.2096235731453, 1719.2693105430142, 959.8146289332668, 1037.1702637889657, 1090.220492347975, 1095.0308976555646, 1097.401915955806, 5733.627314224562, 7072.575645461289, 7075.327843854826, 7096.183938846995, 7127.5010749248095, 7822.1004584472375, 7823.804404889924, 7869.291763741291, 7872.645730942121, 7884.842303153905, 5778.393268706725, 6931.757388491378, 7071.469639777038, 7081.291870812877, 7215.60314182725, 4051.1290072633938, 4103.322951712934, 4110.0752330725345, 4160.708750387444, 4195.391668208093, 8105.230003149692, 8132.959335203286, 8151.470154439942, 8157.510549367057, 8180.427370084156, 6560.573562718408, 7876.212378762078, 8108.2297181767635, 8131.634076466573, 8140.308073813674, 7323.084614423197, 7546.735864244725, 8122.593870306461, 8141.267285944294, 8153.1846815317995, 7884.566348850868, 7904.604769761374, 7917.881231781413, 7940.205979402013, 7943.801404964922, 7527.6988920444755, 7746.690132394641, 7749.457537972513, 7754.7673569793, 7778.299953004257, 8121.106678265268, 8138.511689298661, 8145.307648849677, 8161.673533058611, 8179.100298967228, 4847.22444408907, 4856.975715121402, 4883.658143929891, 4888.437829649636, 4904.975475122602, 7654.770356889302, 7895.289423951642, 7928.682852685828, 7929.326007289214, 7933.8413231736195, 7623.580703061385, 7658.349040331635, 7658.540487570764, 7673.884891726517, 7689.769306920802, 7381.224971378143, 7531.133919599316, 7593.126790419173, 7613.857921311847, 7614.885776713243, 7343.77968660941, 7390.630468476447, 7395.963020184865, 7397.8150546236775, 7399.445041621792, 7548.094228692592, 7561.168271490022, 7573.507721998052, 7590.430717696085, 7618.276263754934, 7207.423406127392, 7438.516496427715, 7452.21751716062, 7465.440091993014, 7490.475666703279], "unit": "ms", "name": "prototype.html", "value": 5380.909923897417}, {"lowerIsBetter": false, "replicates": [725.3653053578118, 808.2442915873662, 815.930645895099, 835.4026870787386, 860.7331727164576, 12615.55845545406, 12889.419976101075, 12929.353532323394, 12961.805572916403, 13010.739785204314, 14172.078814877052, 14262.072965257252, 14262.215578143197, 14270.643233919158, 14304.642383940407, 746.9103707555101, 764.9978528128142, 928.1971095002808, 944.763809047738, 945.1068740040664, 873.8863947686792, 916.6150216908915, 927.9164875161234, 942.0532364973193, 945.9148676619103, 992.4591097851652, 1003.794222184454, 1009.8081364540714, 1011.2617789014024, 1012.7620009297809, 984.1142971325793, 987.3730181334832, 995.8307087795056, 999.8400255959011, 1004.9899501004969, 608.8082254089948, 706.1526168597652, 735.4888352594949, 738.2101151767611, 751.4476859508258, 14745.11529308245, 14924.403023879031, 14954.0, 14988.550343489713, 15102.093874367463, 11907.16649834512, 12274.0, 12564.811527826998, 12606.74786504274, 12779.041571882146, 10171.135453486462, 10279.383237005804, 10406.635767748092, 10672.78654426907, 10953.397563134024, 3466.272082862602, 3579.552555930509, 3587.0673624857463, 3593.317269718745, 3624.855005799765, 66963.3303666962, 80084.19915800884, 81928.0, 81932.9999999994, 82085.0, 9684.322097453252, 9827.705168844803, 9877.308588398742, 9917.900820991697, 10469.371837689763, 21271.36185914425, 21499.0, 21505.892470537547, 21544.676829847565, 21740.45648858791, 7359.448041396917, 7424.665890034961, 7597.392208623297, 7649.502782319131, 7775.261350171724, 4065.8170382332864, 4152.792360382029, 4226.1336426032585, 4260.10537787062, 4270.50889147752, 3458.5330980317335, 3519.1905861651962, 3521.29574085184, 3524.9118772030392, 3527.8412471438846, 623.7972658885881, 632.8607706304606, 636.38270877249, 653.9771108011197, 658.8517583543664, 504.66187654271727, 508.123486984948, 524.6851888866726, 531.0891820527813, 534.2040359863774, 8665.43674661145, 8741.08218637034, 8755.693550725695, 8769.736907892773, 8927.910720892838, 493.1197811905803, 493.43255256455365, 495.5490503641669, 537.0092179928105, 541.9241306217133, 4027.81874815634, 4140.4617399738445, 4150.335946248586, 4239.27932251518, 4267.573242675708, 94769.0, 96190.0, 97014.0, 97043.51478242705, 100767.0, 67902.66048669725, 86710.56644716737, 87950.56024719836, 88716.5564172175, 88806.11193888108, 76967.61516192384, 77620.0, 77815.0, 77870.83193752098, 79288.0, 8282.213189746964, 8336.666533338841, 8478.491290522341, 8527.658893644184, 8588.957055214683, 51933.441996740155, 52619.73690131525, 53017.4698253028, 53292.46707532875, 54242.728786355816, 73134.26865731274, 73508.63245683737, 73519.63240183765, 77230.0, 78074.6096269515, 10996.12031037531, 11100.167487438635, 11364.431778411212, 11503.76992460163, 11824.0, 12044.939775301418, 12079.335636540074, 12087.214331068453, 12088.456019478968, 12237.388130593612, 11482.82775758381, 11954.940225298818, 12020.579279725167, 12067.975202519374, 12353.32056736888, 9597.520123993912, 9873.0, 11157.49791259379, 11835.349055802013, 11896.940515297714, 9356.859647105162, 9907.306488545733, 10444.373337599769, 10897.237193396386, 11152.442377881236, 9354.906450935403, 9512.191463725661, 9532.189763869872, 9905.207583393456, 10086.394816311045, 9016.59425325875, 9399.0, 9789.51052447389, 9835.918049014459, 9937.900620993698], "unit": "ms", "name": "yui.html", "value": 6991.771219020638}], "name": "dromaeo_css", "value": 7659.37547165295}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [115.0, 106.0, 94.0, 166.0, 166.0, 152.0, 115.0, 136.0, 166.0, 166.0], "unit": "ms", "name": "ai-astar", "value": 138.2}, {"lowerIsBetter": true, "replicates": [147.0, 136.0, 177.0, 183.0, 104.0, 167.0, 128.0, 140.0, 137.0, 141.0], "unit": "ms", "name": "audio-beat-detection", "value": 146.0}, {"lowerIsBetter": true, "replicates": [187.0, 197.0, 190.0, 203.0, 215.0, 197.0, 197.0, 196.0, 186.0, 199.0], "unit": "ms", "name": "audio-dft", "value": 196.7}, {"lowerIsBetter": true, "replicates": [60.0, 62.0, 72.0, 122.0, 56.0, 60.0, 57.0, 59.0, 89.0, 56.0], "unit": "ms", "name": "audio-fft", "value": 69.3}, {"lowerIsBetter": true, "replicates": [76.0, 81.0, 125.0, 60.0, 111.0, 112.0, 110.0, 88.0, 111.0, 94.0], "unit": "ms", "name": "audio-oscillator", "value": 96.8}, {"lowerIsBetter": true, "replicates": [87.0, 100.0, 125.0, 87.0, 88.0, 87.0, 88.0, 89.0, 88.0, 88.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 92.7}, {"lowerIsBetter": true, "replicates": [98.0, 96.0, 107.0, 142.0, 123.0, 95.0, 94.0, 94.0, 96.0, 96.0], "unit": "ms", "name": "imaging-darkroom", "value": 104.1}, {"lowerIsBetter": true, "replicates": [77.0, 77.0, 148.0, 76.0, 142.0, 107.0, 125.0, 143.0, 147.0, 91.0], "unit": "ms", "name": "imaging-desaturate", "value": 113.3}, {"lowerIsBetter": true, "replicates": [59.0, 60.0, 59.0, 58.0, 59.0, 57.0, 59.0, 66.0, 58.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 59.2}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 70.0, 66.0, 66.0, 68.0, 68.0, 70.0, 70.0, 71.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.3}, {"lowerIsBetter": true, "replicates": [75.0, 79.0, 93.0, 103.0, 111.0, 109.0, 111.0, 95.0, 84.0, 86.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 94.6}, {"lowerIsBetter": true, "replicates": [124.0, 133.0, 129.0, 130.0, 124.0, 132.0, 131.0, 124.0, 133.0, 132.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 129.2}, {"lowerIsBetter": true, "replicates": [145.0, 150.0, 149.0, 140.0, 141.0, 146.0, 139.0, 127.0, 165.0, 178.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 148.0}, {"lowerIsBetter": true, "replicates": [69.0, 66.0, 65.0, 67.0, 64.0, 70.0, 97.0, 92.0, 94.0, 97.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 78.1}], "name": "kraken", "value": 1534.4999999999998}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [148.65467518953471], "unit": "score", "name": "Richards", "value": 237.4765539999999}, {"lowerIsBetter": false, "replicates": [158.07777426493834], "unit": "score", "name": "DeltaBlue", "value": 418.262468}, {"lowerIsBetter": false, "replicates": [283.36639274582035], "unit": "score", "name": "Encrypt", "value": 939.3527489999996}, {"lowerIsBetter": false, "replicates": [4960.39603960396], "unit": "score", "name": "Decrypt", "value": 53.661239520958084}, {"lowerIsBetter": false, "replicates": [948.7666034155598], "unit": "score", "name": "RayTrace", "value": 779.9484060000001}, {"lowerIsBetter": false, "replicates": [843.1703204047218], "unit": "score", "name": "Earley", "value": 790.4251180000002}, {"lowerIsBetter": false, "replicates": [12662.5], "unit": "score", "name": "Boyer", "value": 52.632813425468896}, {"lowerIsBetter": false, "replicates": [26894.736842105263], "unit": "score", "name": "RegExp", "value": 33.87224070450098}, {"lowerIsBetter": false, "replicates": [1567.398119122257], "unit": "score", "name": "Splay", "value": 51.99125799999999}, {"lowerIsBetter": false, "replicates": [4513.513513513513], "unit": "score", "name": "NavierStokes", "value": 328.7904191616765}], "name": "v8_7", "value": 19927.5895281868}]} 16:37:35 INFO - RETURN: dromaeo_css: 7659.38 16:37:35 INFO - RETURN: kraken: 1534.50 16:37:35 INFO - RETURN: v8_7: 19927.59 16:37:35 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "19927.59"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1534.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7659.38"}}} 16:37:35 INFO - Return code: 0 16:37:35 INFO - # TBPL SUCCESS # 16:37:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 16:37:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 16:37:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 16:37:35 INFO - 2015-11-20 16:37:35.389 screenresolution[2247:19905] starting screenresolution argv=screenresolution get 16:37:35 INFO - 2015-11-20 16:37:35.392 screenresolution[2247:19905] Display 0: 1600x1200x32@60 16:37:35 INFO - 2015-11-20 16:37:35.398 screenresolution[2248:19908] starting screenresolution argv=screenresolution list 16:37:35 INFO - Available Modes on Display 0 16:37:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 16:37:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 16:37:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 16:37:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 16:37:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 16:37:35 INFO - Intel Iris: 16:37:35 INFO - Chipset Model: Intel Iris 16:37:35 INFO - Type: GPU 16:37:35 INFO - Bus: Built-In 16:37:35 INFO - VRAM (Dynamic, Max): 1536 MB 16:37:35 INFO - Vendor: Intel (0x8086) 16:37:35 INFO - Device ID: 0x0a2e 16:37:35 INFO - Revision ID: 0x0009 16:37:35 INFO - Displays: 16:37:35 INFO - Display: 16:37:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 16:37:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 16:37:35 INFO - Display Serial Number: 1600x1200 60 16:37:35 INFO - Main Display: Yes 16:37:35 INFO - Mirror: Off 16:37:35 INFO - Online: Yes 16:37:35 INFO - Rotation: Supported 16:37:35 INFO - Return code: 0 16:37:35 INFO - Running post-action listener: _resource_record_post_action 16:37:35 INFO - Running post-run listener: _resource_record_post_run 16:37:36 INFO - Total resource usage - Wall time: 1238s; CPU: 53.0%; Read bytes: 2523136; Write bytes: 693670912; Read time: 39; Write time: 2467 16:37:36 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 334744064; Write bytes: 337634816; Read time: 26409; Write time: 669 16:37:36 INFO - run-tests - Wall time: 1208s; CPU: 53.0%; Read bytes: 2523136; Write bytes: 345669120; Read time: 39; Write time: 1765 16:37:36 INFO - Running post-run listener: _upload_blobber_files 16:37:36 INFO - Blob upload gear active. 16:37:36 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 16:37:36 INFO - Copying logs to upload dir... 16:37:36 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1279.625582 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 19 secs) (at 2015-11-20 16:37:36.743934) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:37:36.747735) ========= 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.EnkqetoiUA/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.Eij1VI7zXq/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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 build_url:https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009561 build_url: 'https://queue.taskcluster.net/v1/task/nUKKJVO9STKI_x4moyUMww/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.01 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-20 16:37:36.770996) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:37:36.771333) ========= 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.EnkqetoiUA/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.Eij1VI7zXq/Listeners TMPDIR=/var/folders/0k/x84zh_fj74941yslkv8b5zhm00000w/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.005270 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-20 16:37:36.819964) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 16:37:36.820272) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-20 16:37:36.820628) ========= ========= Total master_lag: 0.20 =========