builder: fx-team_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0062 starttime: 1447650774.24 results: success (0) buildid: 20151115191934 builduid: c20a87a03ec44d88be4f4c4a773e5b58 revision: 04fb61e343addd47b88ac694041c0bce5a98cfc0 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:54.243218) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:54.243653) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:54.243941) ========= 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.fcd0Vvo1Kh/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.Tri4sMhelj/Listeners TMPDIR=/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/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:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006423 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:54.274527) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:54.274922) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:55.114747) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:55.115091) ========= 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.fcd0Vvo1Kh/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.Tri4sMhelj/Listeners TMPDIR=/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005586 ========= master_lag: 0.05 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:55.174146) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:55.174462) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:55.174836) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:55.175127) ========= 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.fcd0Vvo1Kh/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.Tri4sMhelj/Listeners TMPDIR=/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/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:0x0:0x0 using PTY: False --2015-11-15 21:12:55-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 6.73M=0.002s 2015-11-15 21:12:55 (6.73 MB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.176549 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:55.379929) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:55.380215) ========= 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.fcd0Vvo1Kh/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.Tri4sMhelj/Listeners TMPDIR=/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.022325 ========= master_lag: 0.06 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:55.462162) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:55.462475) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 04fb61e343addd47b88ac694041c0bce5a98cfc0 --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 04fb61e343addd47b88ac694041c0bce5a98cfc0 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fcd0Vvo1Kh/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.Tri4sMhelj/Listeners TMPDIR=/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/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:0x0:0x0 using PTY: False 2015-11-15 21:12:55,546 truncating revision to first 12 chars 2015-11-15 21:12:55,546 Setting DEBUG logging. 2015-11-15 21:12:55,546 attempt 1/10 2015-11-15 21:12:55,546 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/04fb61e343ad?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-15 21:12:55,818 unpacking tar archive at: fx-team-04fb61e343ad/testing/mozharness/ program finished with exit code 0 elapsedTime=0.675181 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:56.159136) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:56.159481) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:56.179316) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:56.179748) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-15 21:12:56.180226) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2015-11-15 21:12:56.180517) ========= /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.fcd0Vvo1Kh/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.Tri4sMhelj/Listeners TMPDIR=/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/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:0x0:0x0 using PTY: False 21:12:56 INFO - MultiFileLogger online at 20151115 21:12:56 in /builds/slave/test 21:12:56 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 21:12:56 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 21:12:56 INFO - {'append_to_log': False, 21:12:56 INFO - 'base_work_dir': '/builds/slave/test', 21:12:56 INFO - 'blob_upload_branch': 'Fx-Team', 21:12:56 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 21:12:56 INFO - 'branch': 'Fx-Team', 21:12:56 INFO - 'buildbot_json_path': 'buildprops.json', 21:12:56 INFO - 'config_files': ('talos/mac_config.py',), 21:12:56 INFO - 'default_actions': ('clobber', 21:12:56 INFO - 'read-buildbot-config', 21:12:56 INFO - 'download-and-extract', 21:12:56 INFO - 'populate-webroot', 21:12:56 INFO - 'create-virtualenv', 21:12:56 INFO - 'install', 21:12:56 INFO - 'run-tests'), 21:12:56 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 21:12:56 INFO - 'download_minidump_stackwalk': True, 21:12:56 INFO - 'download_symbols': 'ondemand', 21:12:56 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 21:12:56 INFO - 'tooltool.py': '/tools/tooltool.py', 21:12:56 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 21:12:56 INFO - '/tools/misc-python/virtualenv.py')}, 21:12:56 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 21:12:56 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 21:12:56 INFO - 'installer_path': 'installer.exe', 21:12:56 INFO - 'log_level': 'info', 21:12:56 INFO - 'log_name': 'talos', 21:12:56 INFO - 'log_to_console': True, 21:12:56 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 21:12:56 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 21:12:56 INFO - 'opt_config_files': (), 21:12:56 INFO - 'pip_index': False, 21:12:56 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:12:56 INFO - 'cmd': ('bash', 21:12:56 INFO - '-c', 21:12:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:12:56 INFO - 'enabled': True, 21:12:56 INFO - 'halt_on_failure': False, 21:12:56 INFO - 'name': 'check_screen_resolution'},), 21:12:56 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 21:12:56 INFO - 'cmd': ('bash', 21:12:56 INFO - '-c', 21:12:56 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 21:12:56 INFO - 'enabled': True, 21:12:56 INFO - 'halt_on_failure': False, 21:12:56 INFO - 'name': 'check_screen_resolution'},), 21:12:56 INFO - 'run_cmd_checks_enabled': True, 21:12:56 INFO - 'sps_profile': False, 21:12:56 INFO - 'sps_profile_interval': 0, 21:12:56 INFO - 'suite': 'dromaeojs-e10s', 21:12:56 INFO - 'system_bits': '64', 21:12:56 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 21:12:56 INFO - 'title': 't-yosemite-r5-0062', 21:12:56 INFO - 'tooltool_cache': '/builds/tooltool_cache', 21:12:56 INFO - 'use_talos_json': True, 21:12:56 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 21:12:56 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 21:12:56 INFO - 'work_dir': 'build'} 21:12:56 INFO - ##### 21:12:56 INFO - ##### Running clobber step. 21:12:56 INFO - ##### 21:12:56 INFO - Running pre-action listener: _resource_record_pre_action 21:12:56 INFO - Running main action method: clobber 21:12:56 INFO - rmtree: /builds/slave/test/build 21:12:56 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 21:12:58 INFO - Running post-action listener: _resource_record_post_action 21:12:58 INFO - ##### 21:12:58 INFO - ##### Running read-buildbot-config step. 21:12:58 INFO - ##### 21:12:58 INFO - Running pre-action listener: _resource_record_pre_action 21:12:58 INFO - Running main action method: read_buildbot_config 21:12:58 INFO - Using buildbot properties: 21:12:58 INFO - { 21:12:58 INFO - "properties": { 21:12:58 INFO - "buildnumber": 56, 21:12:58 INFO - "product": "firefox", 21:12:58 INFO - "script_repo_revision": "production", 21:12:58 INFO - "builddir": "fx-team_yosemite_test-dromaeojs-e10s", 21:12:58 INFO - "repository": "", 21:12:58 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 fx-team talos dromaeojs-e10s", 21:12:58 INFO - "buildid": "20151115191934", 21:12:58 INFO - "slavename": "t-yosemite-r5-0062", 21:12:58 INFO - "pgo_build": "False", 21:12:58 INFO - "basedir": "/builds/slave/test", 21:12:58 INFO - "project": "", 21:12:58 INFO - "platform": "yosemite", 21:12:58 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 21:12:58 INFO - "slavebuilddir": "test", 21:12:58 INFO - "scheduler": "tests-fx-team-macosx64-talos", 21:12:58 INFO - "branch": "fx-team", 21:12:58 INFO - "repo_path": "integration/fx-team", 21:12:58 INFO - "stage_platform": "macosx64", 21:12:58 INFO - "builduid": "c20a87a03ec44d88be4f4c4a773e5b58", 21:12:58 INFO - "revision": "04fb61e343addd47b88ac694041c0bce5a98cfc0" 21:12:58 INFO - }, 21:12:58 INFO - "sourcestamp": { 21:12:58 INFO - "repository": "", 21:12:58 INFO - "hasPatch": false, 21:12:58 INFO - "project": "", 21:12:58 INFO - "branch": "fx-team-macosx64-talos", 21:12:58 INFO - "changes": [ 21:12:58 INFO - { 21:12:58 INFO - "category": null, 21:12:58 INFO - "files": [ 21:12:58 INFO - { 21:12:58 INFO - "url": null, 21:12:58 INFO - "name": "https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 21:12:58 INFO - } 21:12:58 INFO - ], 21:12:58 INFO - "repository": "", 21:12:58 INFO - "rev": "04fb61e343addd47b88ac694041c0bce5a98cfc0", 21:12:58 INFO - "who": "philringnalda@gmail.com", 21:12:58 INFO - "when": 1447650704, 21:12:58 INFO - "number": 6664819, 21:12:58 INFO - "comments": "Merge m-c to f-t", 21:12:58 INFO - "project": "", 21:12:58 INFO - "at": "Sun 15 Nov 2015 21:11:44", 21:12:58 INFO - "branch": "fx-team-macosx64-talos", 21:12:58 INFO - "revlink": "", 21:12:58 INFO - "properties": [ 21:12:58 INFO - [ 21:12:58 INFO - "buildid", 21:12:58 INFO - "20151115191934", 21:12:58 INFO - "Change" 21:12:58 INFO - ], 21:12:58 INFO - [ 21:12:58 INFO - "builduid", 21:12:58 INFO - "c20a87a03ec44d88be4f4c4a773e5b58", 21:12:58 INFO - "Change" 21:12:58 INFO - ], 21:12:58 INFO - [ 21:12:58 INFO - "pgo_build", 21:12:58 INFO - "False", 21:12:58 INFO - "Change" 21:12:58 INFO - ] 21:12:58 INFO - ], 21:12:58 INFO - "revision": "04fb61e343addd47b88ac694041c0bce5a98cfc0" 21:12:58 INFO - } 21:12:58 INFO - ], 21:12:58 INFO - "revision": "04fb61e343addd47b88ac694041c0bce5a98cfc0" 21:12:58 INFO - } 21:12:58 INFO - } 21:12:58 INFO - Found installer url https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 21:12:58 INFO - Running post-action listener: _resource_record_post_action 21:12:58 INFO - ##### 21:12:58 INFO - ##### Running download-and-extract step. 21:12:58 INFO - ##### 21:12:58 INFO - Running pre-action listener: _resource_record_pre_action 21:12:58 INFO - Running main action method: download_and_extract 21:12:58 INFO - mkdir: /builds/slave/test/build/tests 21:12:58 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')]} 21:12:58 INFO - https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 21:12:58 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/test_packages.json 21:12:58 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/test_packages.json 21:12:58 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 21:12:58 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 21:12:59 INFO - Downloaded 1149 bytes. 21:12:59 INFO - Reading from file /builds/slave/test/build/test_packages.json 21:12:59 INFO - Using the following test package requirements: 21:12:59 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:12:59 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:12:59 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 21:12:59 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:12:59 INFO - u'jsshell-mac.zip'], 21:12:59 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:12:59 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 21:12:59 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:12:59 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:12:59 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 21:12:59 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:12:59 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 21:12:59 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:12:59 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 21:12:59 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 21:12:59 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 21:12:59 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 21:12:59 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 21:12:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:12:59 INFO - https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:12:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:12:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:12:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/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 21:12:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/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 21:13:00 INFO - Downloaded 17464151 bytes. 21:13:00 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 21:13:00 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:13:00 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 21:13:05 INFO - Return code: 0 21:13:05 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 21:13:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:05 INFO - https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 21:13:05 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:13:05 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:13:05 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/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 21:13:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/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 21:13:08 INFO - Downloaded 17464151 bytes. 21:13:08 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 21:13:08 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 21:13:08 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 21:13:14 INFO - Return code: 0 21:13:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:14 INFO - https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 21:13:14 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:13:14 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:13:14 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/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 21:13:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/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 21:13:15 INFO - Downloaded 11131693 bytes. 21:13:15 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 21:13:15 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 21:13:15 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 21:13:16 INFO - Return code: 0 21:13:16 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')]} 21:13:16 INFO - https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 21:13:16 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:13:16 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:13:16 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 21:13:16 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/ZjTbuTY2RkSkT863-Sdzjw/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 21:13:19 INFO - Downloaded 108681065 bytes. 21:13:19 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:13:19 INFO - mkdir: /builds/slave/test/properties 21:13:19 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 21:13:19 INFO - Writing to file /builds/slave/test/properties/build_url 21:13:19 INFO - Contents: 21:13:19 INFO - build_url:https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 21:13:19 INFO - Running post-action listener: _resource_record_post_action 21:13:19 INFO - Running post-action listener: set_extra_try_arguments 21:13:19 INFO - ##### 21:13:19 INFO - ##### Running populate-webroot step. 21:13:19 INFO - ##### 21:13:19 INFO - Running pre-action listener: _resource_record_pre_action 21:13:19 INFO - Running main action method: populate_webroot 21:13:19 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 21:13:19 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 21:13:19 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 21:13:19 INFO - '../fennec_ids.txt'], 21:13:19 INFO - 'tests': ['tcheck2']}, 21:13:19 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 21:13:19 INFO - '--tppagecycles', 21:13:19 INFO - '7'], 21:13:19 INFO - 'tests': ['tsvgm']}}, 21:13:19 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 21:13:19 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 21:13:19 INFO - 'tests': ['tresize', 'tcanvasmark']}, 21:13:19 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:13:19 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 21:13:19 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 21:13:19 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:13:19 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:19 INFO - 'talos_options': ['--e10s'], 21:13:19 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 21:13:19 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:19 INFO - 'tests': ['damp', 'tps']}, 21:13:19 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:19 INFO - 'talos_options': ['--e10s'], 21:13:19 INFO - 'tests': ['damp', 'tps']}, 21:13:19 INFO - 'g3': {'tests': ['dromaeo_dom']}, 21:13:19 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 21:13:19 INFO - 'other': {'tests': ['a11yr', 21:13:19 INFO - 'ts_paint', 21:13:19 INFO - 'tpaint', 21:13:19 INFO - 'sessionrestore', 21:13:19 INFO - 'sessionrestore_no_auto_restore']}, 21:13:19 INFO - 'other-e10s': {'talos_options': ['--e10s'], 21:13:19 INFO - 'tests': ['a11yr', 21:13:19 INFO - 'ts_paint', 21:13:19 INFO - 'tpaint', 21:13:19 INFO - 'sessionrestore', 21:13:19 INFO - 'sessionrestore_no_auto_restore']}, 21:13:19 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 21:13:19 INFO - 'tests': ['a11yr', 21:13:19 INFO - 'ts_paint', 21:13:19 INFO - 'tpaint', 21:13:19 INFO - 'sessionrestore', 21:13:19 INFO - 'sessionrestore_no_auto_restore']}, 21:13:19 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 21:13:19 INFO - 'tests': ['a11yr', 21:13:19 INFO - 'ts_paint', 21:13:19 INFO - 'tpaint', 21:13:19 INFO - 'sessionrestore', 21:13:19 INFO - 'sessionrestore_no_auto_restore']}, 21:13:19 INFO - 'other_l64': {'tests': ['a11yr', 21:13:19 INFO - 'ts_paint', 21:13:19 INFO - 'tpaint', 21:13:19 INFO - 'sessionrestore', 21:13:19 INFO - 'sessionrestore_no_auto_restore']}, 21:13:19 INFO - 'other_nol64': {'tests': ['a11yr', 21:13:19 INFO - 'ts_paint', 21:13:19 INFO - 'tpaint', 21:13:19 INFO - 'sessionrestore', 21:13:19 INFO - 'sessionrestore_no_auto_restore']}, 21:13:19 INFO - 'svgr': {'tests': ['tsvgx', 21:13:19 INFO - 'tsvgr_opacity', 21:13:19 INFO - 'tart', 21:13:19 INFO - 'tscrollx', 21:13:19 INFO - 'cart']}, 21:13:19 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 21:13:19 INFO - 'tests': ['tsvgx', 21:13:19 INFO - 'tsvgr_opacity', 21:13:19 INFO - 'tart', 21:13:19 INFO - 'tscrollx', 21:13:19 INFO - 'cart']}, 21:13:19 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:19 INFO - 'tests': ['tp5o']}, 21:13:19 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:19 INFO - 'talos_options': ['--e10s'], 21:13:19 INFO - 'tests': ['tp5o']}, 21:13:19 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:19 INFO - 'talos_options': ['--xperf_path', 21:13:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:13:19 INFO - 'tests': ['tp5n']}, 21:13:19 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 21:13:19 INFO - 'talos_options': ['--e10s', 21:13:19 INFO - '--xperf_path', 21:13:19 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 21:13:19 INFO - 'tests': ['tp5n']}}, 21:13:19 INFO - 'talos.zip': {'path': '', 21:13:19 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 21:13:19 INFO - Running post-action listener: _resource_record_post_action 21:13:19 INFO - ##### 21:13:19 INFO - ##### Running create-virtualenv step. 21:13:19 INFO - ##### 21:13:19 INFO - Running pre-action listener: _resource_record_pre_action 21:13:19 INFO - Running main action method: create_virtualenv 21:13:19 INFO - Creating virtualenv /builds/slave/test/build/venv 21:13:19 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 21:13:19 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 21:13:19 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 21:13:19 INFO - Using real prefix '/tools/python27' 21:13:19 INFO - New python executable in /builds/slave/test/build/venv/bin/python 21:13:20 INFO - Installing distribute.............................................................................................................................................................................................done. 21:13:24 INFO - Installing pip.................done. 21:13:24 INFO - Return code: 0 21:13:24 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 21:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:24 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 0x1025b6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102593228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd833d8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d99f0>, '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 0x102239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024cd8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcd0Vvo1Kh/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.Tri4sMhelj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:13:24 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 21:13:24 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 21:13:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcd0Vvo1Kh/Render', 21:13:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:24 INFO - 'HOME': '/Users/cltbld', 21:13:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:24 INFO - 'LOGNAME': 'cltbld', 21:13:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:24 INFO - 'MOZ_NO_REMOTE': '1', 21:13:24 INFO - 'NO_EM_RESTART': '1', 21:13:24 INFO - 'PAGER': '/bin/cat', 21:13:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:24 INFO - 'PWD': '/builds/slave/test', 21:13:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:24 INFO - 'SHELL': '/bin/bash', 21:13:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tri4sMhelj/Listeners', 21:13:24 INFO - 'TMPDIR': '/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/', 21:13:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:24 INFO - 'USER': 'cltbld', 21:13:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:24 INFO - 'XPC_FLAGS': '0x0', 21:13:24 INFO - 'XPC_SERVICE_NAME': '0', 21:13:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:25 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 21:13:25 INFO - Cleaning up... 21:13:25 INFO - Return code: 0 21:13:25 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 21:13:25 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')]} 21:13:25 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:25 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:25 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')]} 21:13:25 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:25 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:25 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 0x1025b6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102593228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd833d8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d99f0>, '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 0x102239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024cd8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcd0Vvo1Kh/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.Tri4sMhelj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:13:25 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 21:13:25 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 21:13:25 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcd0Vvo1Kh/Render', 21:13:25 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:25 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:25 INFO - 'HOME': '/Users/cltbld', 21:13:25 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:25 INFO - 'LOGNAME': 'cltbld', 21:13:25 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:25 INFO - 'MOZ_NO_REMOTE': '1', 21:13:25 INFO - 'NO_EM_RESTART': '1', 21:13:25 INFO - 'PAGER': '/bin/cat', 21:13:25 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:25 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:25 INFO - 'PWD': '/builds/slave/test', 21:13:25 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:25 INFO - 'SHELL': '/bin/bash', 21:13:25 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tri4sMhelj/Listeners', 21:13:25 INFO - 'TMPDIR': '/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/', 21:13:25 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:25 INFO - 'USER': 'cltbld', 21:13:25 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:25 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:25 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:25 INFO - 'XPC_FLAGS': '0x0', 21:13:25 INFO - 'XPC_SERVICE_NAME': '0', 21:13:25 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:13:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:25 INFO - Downloading/unpacking psutil>=0.7.1 21:13:25 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 21:13:25 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 21:13:25 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 21:13:25 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 21:13:25 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 21:13:25 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 21:13:28 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 21:13:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 21:13:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 21:13:28 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:13:28 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:13:28 INFO - Installing collected packages: psutil 21:13:28 INFO - Running setup.py install for psutil 21:13:28 INFO - building 'psutil._psutil_osx' extension 21:13:28 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 21:13:28 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 21:13:28 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 21:13:29 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 21:13:29 INFO - building 'psutil._psutil_posix' extension 21:13:29 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 21:13:29 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 21:13:29 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 21:13:29 INFO - ^ 21:13:29 INFO - 1 warning generated. 21:13:29 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 21:13:29 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 21:13:29 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 21:13:29 INFO - Successfully installed psutil 21:13:29 INFO - Cleaning up... 21:13:29 INFO - Return code: 0 21:13:29 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 21:13: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')]} 21:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13: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')]} 21:13:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:29 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 0x1025b6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102593228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd833d8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d99f0>, '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 0x102239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024cd8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcd0Vvo1Kh/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.Tri4sMhelj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:13:29 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 21:13:29 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 21:13:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcd0Vvo1Kh/Render', 21:13:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:29 INFO - 'HOME': '/Users/cltbld', 21:13:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:29 INFO - 'LOGNAME': 'cltbld', 21:13:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:29 INFO - 'MOZ_NO_REMOTE': '1', 21:13:29 INFO - 'NO_EM_RESTART': '1', 21:13:29 INFO - 'PAGER': '/bin/cat', 21:13:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:29 INFO - 'PWD': '/builds/slave/test', 21:13:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:29 INFO - 'SHELL': '/bin/bash', 21:13:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tri4sMhelj/Listeners', 21:13:29 INFO - 'TMPDIR': '/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/', 21:13:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:29 INFO - 'USER': 'cltbld', 21:13:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:29 INFO - 'XPC_FLAGS': '0x0', 21:13:29 INFO - 'XPC_SERVICE_NAME': '0', 21:13:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:13:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:29 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 21:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:32 INFO - Downloading mozsystemmonitor-0.0.tar.gz 21:13:32 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 21:13:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 21:13:32 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 21:13:32 INFO - Installing collected packages: mozsystemmonitor 21:13:32 INFO - Running setup.py install for mozsystemmonitor 21:13:32 INFO - Successfully installed mozsystemmonitor 21:13:32 INFO - Cleaning up... 21:13:32 INFO - Return code: 0 21:13:32 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 21:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:32 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:32 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 0x1025b6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102593228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd833d8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d99f0>, '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 0x102239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024cd8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcd0Vvo1Kh/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.Tri4sMhelj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:13:32 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 21:13:32 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 21:13:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcd0Vvo1Kh/Render', 21:13:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:32 INFO - 'HOME': '/Users/cltbld', 21:13:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:32 INFO - 'LOGNAME': 'cltbld', 21:13:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:32 INFO - 'MOZ_NO_REMOTE': '1', 21:13:32 INFO - 'NO_EM_RESTART': '1', 21:13:32 INFO - 'PAGER': '/bin/cat', 21:13:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:32 INFO - 'PWD': '/builds/slave/test', 21:13:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:32 INFO - 'SHELL': '/bin/bash', 21:13:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tri4sMhelj/Listeners', 21:13:32 INFO - 'TMPDIR': '/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/', 21:13:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:32 INFO - 'USER': 'cltbld', 21:13:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:32 INFO - 'XPC_FLAGS': '0x0', 21:13:32 INFO - 'XPC_SERVICE_NAME': '0', 21:13:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:13:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:33 INFO - Downloading/unpacking blobuploader==1.2.4 21:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:35 INFO - Downloading blobuploader-1.2.4.tar.gz 21:13:35 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 21:13:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 21:13:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 21:13: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 21:13: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 21:13: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 21:13: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 21:13: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 21:13: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 21:13:36 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 21:13:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 21:13:36 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 21:13: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 21:13: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 21:13: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 21:13: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 21:13: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 21:13: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 21:13:37 INFO - Downloading docopt-0.6.1.tar.gz 21:13:37 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 21:13:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 21:13:37 INFO - Installing collected packages: blobuploader, requests, docopt 21:13:37 INFO - Running setup.py install for blobuploader 21:13:37 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 21:13:37 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 21:13:37 INFO - Running setup.py install for requests 21:13:38 INFO - Running setup.py install for docopt 21:13:38 INFO - Successfully installed blobuploader requests docopt 21:13:38 INFO - Cleaning up... 21:13:38 INFO - Return code: 0 21:13:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:38 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 0x1025b6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102593228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd833d8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d99f0>, '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 0x102239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024cd8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcd0Vvo1Kh/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.Tri4sMhelj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:13:38 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 21:13:38 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 21:13:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcd0Vvo1Kh/Render', 21:13:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:38 INFO - 'HOME': '/Users/cltbld', 21:13:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:38 INFO - 'LOGNAME': 'cltbld', 21:13:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:38 INFO - 'MOZ_NO_REMOTE': '1', 21:13:38 INFO - 'NO_EM_RESTART': '1', 21:13:38 INFO - 'PAGER': '/bin/cat', 21:13:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:38 INFO - 'PWD': '/builds/slave/test', 21:13:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:38 INFO - 'SHELL': '/bin/bash', 21:13:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tri4sMhelj/Listeners', 21:13:38 INFO - 'TMPDIR': '/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/', 21:13:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:38 INFO - 'USER': 'cltbld', 21:13:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:38 INFO - 'XPC_FLAGS': '0x0', 21:13:38 INFO - 'XPC_SERVICE_NAME': '0', 21:13:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:13:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:13:39 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-bNagmE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:13:39 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-IxsqvD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:13:39 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-JnXqc9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:13:39 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-Vjea7d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:13:39 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-lCRyIO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:13:39 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-DvF9Wo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:13:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:13:39 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-PmlL_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:13:40 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-zfc5gy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:13:40 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-Lt5t63-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:13:40 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-A4IOFG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:13:40 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-zBUXdC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:13:40 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-8xCT1U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:13:40 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-t9z0rp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:13:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:13:40 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-QMWo3Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:41 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-0RO6jl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:13:41 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-9mqMKZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:13:41 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:13:41 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-r3g7mh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:13:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 21:13:41 INFO - Running setup.py install for manifestparser 21:13:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 21:13:41 INFO - Running setup.py install for mozcrash 21:13:41 INFO - Running setup.py install for mozdebug 21:13:41 INFO - Running setup.py install for mozdevice 21:13:42 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 21:13:42 INFO - Installing dm script to /builds/slave/test/build/venv/bin 21:13:42 INFO - Running setup.py install for mozfile 21:13:42 INFO - Running setup.py install for mozhttpd 21:13:42 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 21:13:42 INFO - Running setup.py install for mozinfo 21:13:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 21:13:42 INFO - Running setup.py install for mozInstall 21:13:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 21:13:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 21:13:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 21:13:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 21:13:42 INFO - Running setup.py install for mozleak 21:13:43 INFO - Running setup.py install for mozlog 21:13:43 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 21:13:43 INFO - Running setup.py install for moznetwork 21:13:43 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 21:13:43 INFO - Running setup.py install for mozprocess 21:13:43 INFO - Running setup.py install for mozprofile 21:13:43 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 21:13:43 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 21:13:43 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 21:13:43 INFO - Running setup.py install for mozrunner 21:13:44 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 21:13:44 INFO - Running setup.py install for mozscreenshot 21:13:44 INFO - Running setup.py install for moztest 21:13:44 INFO - Running setup.py install for mozversion 21:13:44 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 21:13:44 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 21:13:44 INFO - Cleaning up... 21:13:44 INFO - Return code: 0 21:13:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:13:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13:44 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 0x1025b6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102593228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd833d8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d99f0>, '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 0x102239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024cd8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcd0Vvo1Kh/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.Tri4sMhelj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:13:44 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 21:13:44 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 21:13:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcd0Vvo1Kh/Render', 21:13:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:44 INFO - 'HOME': '/Users/cltbld', 21:13:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:44 INFO - 'LOGNAME': 'cltbld', 21:13:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:44 INFO - 'MOZ_NO_REMOTE': '1', 21:13:44 INFO - 'NO_EM_RESTART': '1', 21:13:44 INFO - 'PAGER': '/bin/cat', 21:13:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:44 INFO - 'PWD': '/builds/slave/test', 21:13:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:44 INFO - 'SHELL': '/bin/bash', 21:13:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tri4sMhelj/Listeners', 21:13:44 INFO - 'TMPDIR': '/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/', 21:13:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:44 INFO - 'USER': 'cltbld', 21:13:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:44 INFO - 'XPC_FLAGS': '0x0', 21:13:44 INFO - 'XPC_SERVICE_NAME': '0', 21:13:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:13:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 21:13:45 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-QA85LF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 21:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 21:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 21:13:45 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-AijNrG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 21:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 21:13:45 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-jf8hke-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 21:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 21:13:45 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-ywhknW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 21:13:45 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)) 21:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 21:13:45 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-Uoi0Ii-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 21:13:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 21:13:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 21:13:45 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-8Or0Jy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 21:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 21:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 21:13:46 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-UG0OSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 21:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 21:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 21:13:46 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-AayWox-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 21:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 21:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 21:13:46 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-_S2zt6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 21:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 21:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 21:13:46 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-KfZ9xq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 21:13:46 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)) 21:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 21:13:46 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-0FxaHS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 21:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 21:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 21:13:46 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-OOi3Jj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 21:13:46 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 21:13:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 21:13:46 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-jWdP7k-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 21:13:47 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)) 21:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 21:13:47 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-OKAs79-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 21:13:47 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)) 21:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:47 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-psgKDW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 21:13:47 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)) 21:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 21:13:47 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-qB2fVI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 21:13:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 21:13:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 21:13:47 INFO - Running setup.py (path:/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/pip-ecGMOv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 21:13:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 21:13:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:13:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 21:13:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 21:13:47 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:13:47 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 21:13:47 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 21:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 21:13:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 21:13:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 21:13:50 INFO - Downloading blessings-1.5.1.tar.gz 21:13:50 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 21:13:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 21:13:50 INFO - Installing collected packages: blessings 21:13:50 INFO - Running setup.py install for blessings 21:13:50 INFO - Successfully installed blessings 21:13:50 INFO - Cleaning up... 21:13:50 INFO - Return code: 0 21:13:50 INFO - Done creating virtualenv /builds/slave/test/build/venv. 21:13:50 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:13:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:13:51 INFO - Reading from file tmpfile_stdout 21:13:51 INFO - Current package versions: 21:13:51 INFO - blessings == 1.5.1 21:13:51 INFO - blobuploader == 1.2.4 21:13:51 INFO - docopt == 0.6.1 21:13:51 INFO - manifestparser == 1.1 21:13:51 INFO - mozInstall == 1.12 21:13:51 INFO - mozcrash == 0.16 21:13:51 INFO - mozdebug == 0.1 21:13:51 INFO - mozdevice == 0.47 21:13:51 INFO - mozfile == 1.2 21:13:51 INFO - mozhttpd == 0.7 21:13:51 INFO - mozinfo == 0.9 21:13:51 INFO - mozleak == 0.1 21:13:51 INFO - mozlog == 3.0 21:13:51 INFO - moznetwork == 0.27 21:13:51 INFO - mozprocess == 0.22 21:13:51 INFO - mozprofile == 0.27 21:13:51 INFO - mozrunner == 6.11 21:13:51 INFO - mozscreenshot == 0.1 21:13:51 INFO - mozsystemmonitor == 0.0 21:13:51 INFO - moztest == 0.7 21:13:51 INFO - mozversion == 1.4 21:13:51 INFO - psutil == 3.1.1 21:13:51 INFO - requests == 1.2.3 21:13:51 INFO - wsgiref == 0.1.2 21:13:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 21:13: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')]} 21:13:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 21:13:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13: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')]} 21:13:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 21:13:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 21:13: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/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 0x1025b6490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x102593228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd833d8c450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1024d99f0>, '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 0x102239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024cd8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcd0Vvo1Kh/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.Tri4sMhelj/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 21:13: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/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 21:13: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/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 21:13:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcd0Vvo1Kh/Render', 21:13:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:13:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:13:51 INFO - 'HOME': '/Users/cltbld', 21:13:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:13:51 INFO - 'LOGNAME': 'cltbld', 21:13:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:13:51 INFO - 'MOZ_NO_REMOTE': '1', 21:13:51 INFO - 'NO_EM_RESTART': '1', 21:13:51 INFO - 'PAGER': '/bin/cat', 21:13:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:13:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:13:51 INFO - 'PWD': '/builds/slave/test', 21:13:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:13:51 INFO - 'SHELL': '/bin/bash', 21:13:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tri4sMhelj/Listeners', 21:13:51 INFO - 'TMPDIR': '/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/', 21:13:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:13:51 INFO - 'USER': 'cltbld', 21:13:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:13:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:13:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:13:51 INFO - 'XPC_FLAGS': '0x0', 21:13:51 INFO - 'XPC_SERVICE_NAME': '0', 21:13:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:13:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 21:13:51 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)) 21:13:51 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)) 21:13:51 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)) 21:13:51 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)) 21:13:51 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)) 21:13:51 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)) 21:13:51 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)) 21:13:51 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)) 21:13:51 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)) 21:13:51 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)) 21:13:51 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)) 21:13:51 INFO - Cleaning up... 21:13:51 INFO - Return code: 0 21:13:51 INFO - Running post-action listener: _resource_record_post_action 21:13:51 INFO - Running post-action listener: _start_resource_monitoring 21:13:51 INFO - Starting resource monitoring. 21:13:51 INFO - ##### 21:13:51 INFO - ##### Running install step. 21:13:51 INFO - ##### 21:13:51 INFO - Running pre-action listener: _resource_record_pre_action 21:13:51 INFO - Running main action method: install 21:13:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 21:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 21:13:51 INFO - Reading from file tmpfile_stdout 21:13:51 INFO - Detecting whether we're running mozinstall >=1.0... 21:13:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 21:13:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 21:13:52 INFO - Reading from file tmpfile_stdout 21:13:52 INFO - Output received: 21:13:52 INFO - Usage: mozinstall [options] installer 21:13:52 INFO - Options: 21:13:52 INFO - -h, --help show this help message and exit 21:13:52 INFO - -d DEST, --destination=DEST 21:13:52 INFO - Directory to install application into. [default: 21:13:52 INFO - "/builds/slave/test"] 21:13:52 INFO - --app=APP Application being installed. [default: firefox] 21:13:52 INFO - mkdir: /builds/slave/test/build/application 21:13:52 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'] 21:13:52 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 21:14:34 INFO - Reading from file tmpfile_stdout 21:14:34 INFO - Output received: 21:14:34 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 21:14:34 INFO - Running post-action listener: _resource_record_post_action 21:14:34 INFO - ##### 21:14:34 INFO - ##### Running run-tests step. 21:14:34 INFO - ##### 21:14:34 INFO - Running pre-action listener: _resource_record_pre_action 21:14:34 INFO - Running main action method: run_tests 21:14:34 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:14:34 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:14:34 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:14:34 INFO - 2015-11-15 21:14:34.846 screenresolution[2845:24830] starting screenresolution argv=screenresolution get 21:14:34 INFO - 2015-11-15 21:14:34.850 screenresolution[2845:24830] Display 0: 1600x1200x32@60 21:14:34 INFO - 2015-11-15 21:14:34.858 screenresolution[2846:24832] starting screenresolution argv=screenresolution list 21:14:34 INFO - Available Modes on Display 0 21:14:34 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:14:34 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:14:34 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:14:34 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:14:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:14:35 INFO - Intel HD Graphics 3000: 21:14:35 INFO - Chipset Model: Intel HD Graphics 3000 21:14:35 INFO - Type: GPU 21:14:35 INFO - Bus: Built-In 21:14:35 INFO - VRAM (Total): 512 MB 21:14:35 INFO - VRAM (Dynamic, Max): 10 21:14:35 INFO - Vendor: Intel (0x8086) 21:14:35 INFO - Device ID: 0x0116 21:14:35 INFO - Revision ID: 0x0009 21:14:35 INFO - Displays: 21:14:35 INFO - Display: 21:14:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:14:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:14:35 INFO - Display Serial Number: 1600x1200 60 21:14:35 INFO - Main Display: Yes 21:14:35 INFO - Mirror: Off 21:14:35 INFO - Online: Yes 21:14:35 INFO - Rotation: Supported 21:14:35 INFO - Return code: 0 21:14:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 21:14:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 21:14:35 INFO - Python 2.7.3 21:14:35 INFO - Return code: 0 21:14:35 INFO - grabbing minidump binary from tooltool 21:14:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 21:14:35 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 0x1024d99f0>, '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 0x102239db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1024cd8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 21:14:35 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 21:14:35 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 21:14:35 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 21:14:35 INFO - Return code: 0 21:14:35 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 21:14:35 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 21:14:35 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 21:14:35 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 21:14:35 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 21:14:35 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/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0062', '--webServer', 'localhost'] in /builds/slave/test/build 21:14:35 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/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0062 --webServer localhost 21:14:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fcd0Vvo1Kh/Render', 21:14:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 21:14:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 21:14:35 INFO - 'HOME': '/Users/cltbld', 21:14:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 21:14:35 INFO - 'LOGNAME': 'cltbld', 21:14:35 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 21:14:35 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 21:14:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 21:14:35 INFO - 'MOZ_NO_REMOTE': '1', 21:14:35 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 21:14:35 INFO - 'NO_EM_RESTART': '1', 21:14:35 INFO - 'PAGER': '/bin/cat', 21:14:35 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 21:14:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 21:14:35 INFO - 'PWD': '/builds/slave/test', 21:14:35 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 21:14:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 21:14:35 INFO - 'SHELL': '/bin/bash', 21:14:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Tri4sMhelj/Listeners', 21:14:35 INFO - 'TMPDIR': '/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/', 21:14:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 21:14:35 INFO - 'USER': 'cltbld', 21:14:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 21:14:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 21:14:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 21:14:35 INFO - 'XPC_FLAGS': '0x0', 21:14:35 INFO - 'XPC_SERVICE_NAME': '0', 21:14:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 21:14:35 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/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0062', '--webServer', 'localhost'] with output_timeout 3600 21:14:35 INFO - mozversion INFO | application_buildid: 20151115191934 21:14:35 INFO - mozversion INFO | application_changeset: 04fb61e343addd47b88ac694041c0bce5a98cfc0 21:14:35 INFO - mozversion INFO | application_display_name: Nightly 21:14:35 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 21:14:35 INFO - mozversion INFO | application_name: Firefox 21:14:35 INFO - mozversion INFO | application_remotingname: firefox 21:14:35 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 21:14:35 INFO - mozversion INFO | application_vendor: Mozilla 21:14:35 INFO - mozversion INFO | application_version: 45.0a1 21:14:35 INFO - mozversion INFO | platform_buildid: 20151115191934 21:14:35 INFO - mozversion INFO | platform_changeset: 04fb61e343addd47b88ac694041c0bce5a98cfc0 21:14:35 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 21:14:35 INFO - mozversion INFO | platform_version: 45.0a1 21:14:35 INFO - 2015-11-15 21:14:35,560 DEBUG : using testdate: 1447650875 21:14:35 INFO - 2015-11-15 21:14:35,560 DEBUG : actual date: 1447650875 21:14:35 INFO - 2015-11-15 21:14:35,570 INFO : starting webserver on 'localhost:50138' 21:14:35 INFO - 2015-11-15 21:14:35,571 INFO : Starting test suite t-yosemite-r5-0062.e 21:14:35 INFO - 2015-11-15 21:14:35,572 INFO : Starting test dromaeo_css 21:14:35 INFO - 2015-11-15 21:14:35,572 DEBUG : operating with platform_type : mac_ 21:14:35 INFO - 2015-11-15 21:14:35,573 INFO : Initialising browser for dromaeo_css test... 21:14:35 INFO - 2015-11-15 21:14:35,588 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/tmpANkWSf/profile http://localhost:50138/getInfo.html 21:14:38 INFO - 2015-11-15 21:14:38,969 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:14:38 INFO - 2015-11-15 21:14:38,970 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:14:38 INFO - 2015-11-15 21:14:38,970 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 21:14:38 INFO - 2015-11-15 21:14:38,970 DEBUG : BROWSER_OUTPUT: __metrics 21:14:39 INFO - 2015-11-15 21:14:39,734 INFO : Browser initialized. 21:14:39 INFO - 2015-11-15 21:14:39,734 INFO : Running cycle 1/1 for dromaeo_css test... 21:14:39 INFO - 2015-11-15 21:14:39,734 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/tmpANkWSf/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:14:52 INFO - 2015-11-15 21:14:52,000 DEBUG : BROWSER_OUTPUT: RSS: Main: 242049024 21:14:52 INFO - 2015-11-15 21:14:52,001 DEBUG : BROWSER_OUTPUT: 21:15:41 INFO - 2015-11-15 21:15:41,726 DEBUG : BROWSER_OUTPUT: 1447650941723 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] 21:17:51 INFO - 2015-11-15 21:17:51,166 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/dromaeo/cssquery-dojo.html (next: http://localhost:50138/tests/dromaeo/cssquery-ext.html) 21:17:52 INFO - 2015-11-15 21:17:52,709 DEBUG : BROWSER_OUTPUT: RSS: Main: 264990720 21:17:52 INFO - 2015-11-15 21:17:52,709 DEBUG : BROWSER_OUTPUT: 21:20:54 INFO - 2015-11-15 21:20:54,906 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/dromaeo/cssquery-ext.html (next: http://localhost:50138/tests/dromaeo/cssquery-jquery.html) 21:20:55 INFO - 2015-11-15 21:20:55,496 DEBUG : BROWSER_OUTPUT: RSS: Main: 272326656 21:20:55 INFO - 2015-11-15 21:20:55,497 DEBUG : BROWSER_OUTPUT: 21:23:57 INFO - 2015-11-15 21:23:57,246 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/dromaeo/cssquery-jquery.html (next: http://localhost:50138/tests/dromaeo/cssquery-mootools.html) 21:23:57 INFO - 2015-11-15 21:23:57,839 DEBUG : BROWSER_OUTPUT: RSS: Main: 273444864 21:23:57 INFO - 2015-11-15 21:23:57,840 DEBUG : BROWSER_OUTPUT: 21:26:59 INFO - 2015-11-15 21:26:59,638 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/dromaeo/cssquery-mootools.html (next: http://localhost:50138/tests/dromaeo/cssquery-prototype.html) 21:27:00 INFO - 2015-11-15 21:27:00,226 DEBUG : BROWSER_OUTPUT: RSS: Main: 278663168 21:27:00 INFO - 2015-11-15 21:27:00,226 DEBUG : BROWSER_OUTPUT: 21:30:02 INFO - 2015-11-15 21:30:02,871 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/dromaeo/cssquery-prototype.html (next: http://localhost:50138/tests/dromaeo/cssquery-yui.html) 21:30:03 INFO - 2015-11-15 21:30:03,498 DEBUG : BROWSER_OUTPUT: RSS: Main: 283922432 21:30:03 INFO - 2015-11-15 21:30:03,498 DEBUG : BROWSER_OUTPUT: 21:33:05 INFO - 2015-11-15 21:33:05,724 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/dromaeo/cssquery-yui.html (next: http://localhost:50138/tests/dromaeo/cssquery-dojo.html) 21:33:05 INFO - 2015-11-15 21:33:05,976 DEBUG : BROWSER_OUTPUT: RSS: Main: 289435648 21:33:05 INFO - 2015-11-15 21:33:05,976 DEBUG : BROWSER_OUTPUT: 21:33:05 INFO - 2015-11-15 21:33:05,976 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:33:05 INFO - 2015-11-15 21:33:05,976 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:33:05 INFO - 2015-11-15 21:33:05,977 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:33:05 INFO - 2015-11-15 21:33:05,977 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:33:05 INFO - 2015-11-15 21:33:05,978 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2545.223706769435;2610.0734239345034;2676.47808677308;2677.1968409477154;2688.87900044498;4277.101808620189;4355.303151495761;4475.7985890635;4482.955170448295;4536.092781443712;4218.704690671654;4356;4361.345798130282;4389.078293558357;4498.325251212312;4092.815823287944;4100.671946244308;4133.379993001044;4135.875923722293;4167.562405947378;220.23885334717994;4110.856120035799;4203.222403855281;4224.746515209097;4241.045764702948;4022.517297924268;4046.979765101185;4081.795910204493;4106.630403263691;4138.296489596776;4115.1975364803575;4132.586741325874;4136.234796562646;4195.888089656243;4233.089885674594;3935.252302062599;4044.0496483326397;4095.672346212296;4133.503979522447;4150.335946248586;4149.502059752849;4260.382244574519;4311.719738217006;4412.029353542215;4466.419365482499;4651.116287905287;4679.368285281477;4739.052189562101;4752.07334569759;4828.348172996635;4702.153612349775;4746.7389293589185;4750;4791.928121078186;4794.5205479452125;4461.888452788641;4470.061287129706;4473.4408198975125;4500.684952053391;4525.637948964075;4891.926621100686;4896.779644915988;4926.5073492650445;4948.975255123773;4979.253112033151;4411.801468933906;4467.084247729208;4592.770361481913;4608.078384323148;4689.812407503729;4703.717776933327;4761.428628564525;4784.354112194878;4806.255030470283;4844.563989240985;4640.512746161672;4679.22792739201;4708.952910470852;4716.6698331116495;4753.025629745894;4494.415725955605;4575.771211439414;4607.6313894889;4685.297205419214;4720.409948756405;3619.2218672985437;3620.8008559528953;3646;3674.2284120334493;3680.0063982724514;3265.232670322472;3320.037189215149;3335.766496345281;3369.124027752802;3376.4260075787174;4359.062801497693;4398.142362239397;4414.668899832525;4427.180971520279;4524.185646583581;4818.180909245437;4822.445418776815;4835.153848076572;4843.660943733976;4883.902321953612;4291.270484017725;4426.358178064227;4453.821847126143;4510.571495707903;4558.2251017327135;4064.248114098901;4084.9387259191135;4101.138760860253;4157.272477316518;4160.479940007499;4897.730624815598;4918.311436398907;4931.97534012342;4933.555979961749;5027.723475208825;4657.231556793091;4714.575688187942;4773.498782627774;4841.515848415131;4881;4954.455009948831;4963.280324352876;4963.528464795839;5024.84925452237;5075.568576670877;4710.81156753726;4718.41019872516;4738.360321356573;4742.549457801503;4767.213409787346;4643.907121857612;4676.859694209179;4746.4541577719;4788.784504697227;4862.927056094232;4609.516000819865;4644.0711857629285;4651.116287905287;4691.460482044608;4696.8121275148615;4642.791074401593;4650.813967441264;4651.372064771348;4653.86038418848;4734.952650473451;4443.4445694288215;4492.236319825703;4503.414556107685;4514.683972122051;4614.215583350771;4517.6837621366185;4566.840160594364;4579.816807327669;4582.060677561025;4694.953050469589;4405.449318835145;4590.517995610413;4614.307853821953;4647.628189744744;4666.92999605013 21:33:05 INFO - 2015-11-15 21:33:05,982 DEBUG : BROWSER_OUTPUT: |1;ext.html;439.86144364525194;454.51594052334264;458.9977050114749;478.7558345243926;497.28887690602426;32704;33427.66572334276;33691.83154084229;34357.141071473256;34426.31147377051;35164.82417587915;35565.46651800225;35839;36175;36217.2756544869;7588;7724.806879827993;7825.960870195641;7857.292843644071;7883.2116788321;7497.925020749804;7541.924580754205;7568.886466703004;7605;7677.2322767723335;7586.4689471737;7676.884846727304;7684.269994350556;7700.229977002311;7734.535927844319;7438.739644112457;7524.736634217831;7584.810379740551;7628.0464941882265;7638.694452221932;7474.813129671747;7612.809679757995;7687.077550693953;7696.11494678108;7755.495892766952;33389.83305083483;33420.665793342;33440.83279583611;34018.82990585056;34165.65834341675;2041.13251867957;2239.3841693534246;2280.395695140789;2528.443742376674;3092.567040614316;21862.30366753795;22535.323940281818;23039.654405183937;23232.186873459515;23716.762832371627;1905.247427266222;1907.0464767616193;1947.2113793913345;1960.9509762255916;1962.4014675523958;203801;205261;205389;207569;208708;36892.262154756754;49202.26196607054;49588.25617615667;50061.74969125131;50503.74748126309;37188.442173367424;37241;37251.25497490035;37257.44113838294;37811.24377512434;11197.272177308449;11340.20618556693;11346.0355869752;11387.658370248906;11450.541978320774;8731.60707768152;8779.561021948877;8795.868061979076;8820.911790882137;8916.598753055998;11807.645770626896;11880.287182769061;11896.643100706993;11981.820272695917;12053.457594408274;5085.491450854959;5186.714730689849;5197.922031169535;5204.661696989683;5211.530962213343;825.5253229393123;830.3979614779237;855.2601999270586;878.9428687135315;879.6437442835662;23907.16324928619;24067.398315042265;24281.271561853173;24340.878295608763;24378.146764863144;843.4138273899581;847.9448835825651;871.6905498547924;888.7511496780912;894.8031433084711;12349.382530873421;12398.81401778974;12424.192427492184;12452.439640216213;12583.11918165738;329835;331797;333689;334893;335034;48250.758746206746;48841.511584883694;48896.26655600169;49213.75393123083;49255.50744492581;1107.534835369147;1107.5403707461473;1119.5353928119903;1123.6348186839145;1140.4639819284923;23766.762332377148;26942;27247;27266;27454.450910981268;43040.784796077074;43848.34227486527;44553;44564.77717611521;44646;228823;230921;232651;233706;234986;35256.64743352534;35314.1171470705;37108.814455927546;38641.42037869491;38803.223935521695;35594;36035.27929441449;36264.456033159;36673.083172919825;37413.438798417505;30138.84930575333;30914.53628195624;31022;31054.53418198774;31190.688093118777;30114.69885301119;30361.848190758905;30402.087937361914;30431.695683042886;32400.513992289663;30610.693893060783;30629.540556891217;31132.533012004384;31237.8438107808;31478.37043259076;25414.237572872844;26959.191224263304;27082.187534374;27239.72760272372;27458.17625471159;20285.59428811445;20443.284485042954;20458.38624841257;20597;20725.170993160104 21:33:05 INFO - 2015-11-15 21:33:05,983 DEBUG : BROWSER_OUTPUT: |2;jquery.html;275.1539017521123;275.4477273067499;279.3895338684973;280.3901514206601;284.04136040862096;11658.533658653643;14204.715905681893;14505.854941450596;14517.854821451769;14944.925275373607;13986.230757308344;14259.50091746789;15755;16388.93471924324;16445.91777041116;4797.424309082915;4957.925631115536;5035.471275516073;5055.39335279767;5132.8460146195675;5034.949650503503;5115;5123.077845987721;5142.07442660321;5144.254083157958;4760.095581839457;5105.438401775802;5263.605229607795;5564.998300305963;5582.609217354787;5535.335759708821;5573.916391254114;5588.86027849303;5605.663660180402;5650.491455769001;5211.557017653504;5347.224652425415;5437.891242175135;5442;5484.890302193934;14655.560333190022;15023.549293521211;15061.924690376587;17859.910700446544;18269.360572379905;1642.6550424410889;1689.628281778019;1715.5711072231943;1716.6395057038037;1792.811754765744;11579.942100289445;11724.88275117255;11974.161808673396;12232.81650775239;12486.188397754117;1460.4085345435117;1480.7630779075405;1486.754685476895;1491.5599898030107;1492.798472206249;42096.1580768386;44060.898477537994;48326.516734832556;48875;55693.72153139249;13560.59318220455;14176.645583860485;14460.276986150651;14465.421383144767;14486.782698259534;20339;20402.795972040385;20437.795622043886;20699.172033118506;20825.583488330147;7298.598577078205;7328.230535793771;7421.666025028887;7625.847483050308;7631.1605723370385;5999.880002400015;6108.664023478751;6131.478824299985;6380.776672816429;6515.381038801306;6722.260551339349;6869.931300686929;6899.896501552481;6941.652917354112;6947.131608548932;2783.6381270434713;2793.539066054119;2809.7752179825566;2812.5359315713085;2819.802613817054;333.2934179539392;343.78513429106806;348.86743037645533;356.7181926278263;357.8640116755668;8851.33614978879;9344.95327523358;9346.0653934606;9365.11031452011;9653.517324133765;380.7258773682944;387.2197521993186;388.3630845413524;397.2908358579921;409.2224772931454;4857.222844344888;4906.1414252505665;5181.766820493087;5203.16749320107;5222;425826;434921;435275;442920;454663;55557.16664250039;56180.438195618335;56929.430705693245;57688.13467797986;58215;418.73201151263214;419.39816363518446;420.8800491859805;422.4423760635992;425.3237352609366;8526.232639062515;8541.14588541141;8612.78468038304;8672.349573782118;8710.520921349387;26777.464450710486;27191.86404067967;27329.863350683914;27651.58522622122;28040.29899252535;37438.251234975694;37758.62241377551;37949.620503794606;38110;38635.2272954545;6344.714487847966;6384.489240860627;6488.351164883474;6550.279469258473;6564.8358791030605;9460.479673618018;9622.290099083606;9631.903680963382;9761.219102471643;9929.304948653813;6919.481038922;7344.375728062961;8103.959480202797;8284.46151000183;8489.660413583388;6791.796246112624;7748.7675369739;7831.8825217622925;8090.555019473985;8264.504129752235;8137.145599711945;8142.837143256983;8203.71287004952;8417.032041315328;8465.95767021161;6160.353162918008;6254.124422580751;6264.185655864709;6350.7777227796805;6374.171357723466;8002.1997800219515;8024.358051355761;8031.156728543652;8043.316318112792;8077.515349079074 21:33:05 INFO - 2015-11-15 21:33:05,987 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1445.5591044731357;1453.4404254362069;1463.7657974724045;1494.8505149485052;1527.9847201527984;5279.340082489689;5465.890682186359;5476.17857321402;5866.5600079994065;6156.938430615693;6391.360863913606;6438.066480360345;6595.7691480798185;6606.3723946225155;6629.436497897673;1866.4773863318258;1899.3637131560943;1902.5719213177063;1906.6377388296248;1906.961860762784;1909.6180763847217;1953.3163392812473;1956.178405069874;1959.8828667659368;1994.601079784049;1892.5741708115634;1924.7401600783855;1924.8748831325988;1955.5404479947201;1957.862949593529;1803.6212395396983;1857.8606604504716;1861.6835138026568;1889.7732272127296;1893.0440127735544;1861.9069046547754;1873.166440933785;1875.4373687893578;1882.6517094337592;1945.4649971257875;6574.76988305407;6661.700223489906;6735.427488663469;6761;6796.558223715443;3985.322495175827;4075.4701888754566;4078.8776336709648;4104.240715467648;4146.647534959532;2184.191849015858;2236.105557776886;2360.5986982212894;2463.9753602463925;2499.3376755159898;736.223284434921;744.8659241336558;748.4685873030155;752.405599576334;773.5397438524069;8500.809886615878;8739.694110706096;8783.604737786814;8899.288056955427;8901.910980890172;3776.811159442017;3788.5264341957254;3827.445020472016;3844.8462061517225;3918.6081391861157;7568.205338439495;7581.962090189514;7605.6577454014705;7646.923530764732;7693.576853273012;4138.79306034697;4138.896527586834;4171.457710497677;4172.395002724588;4233.534311225762;3755.549334079928;3757.5490941087246;3764.5294338207723;3768.3593789055926;3823.25446537928;3146.087634585944;3160.146760374686;3192.2338638726537;3199.7120259176786;3224.6936541028563;995.5918073589794;1001.519270750044;1002.2483137646765;1002.283367392318;1026.958921643141;1047.7537778622018;1076.983845242322;1092.0608276881876;1107.374333501569;1109.4120116338354;6179.752809887555;6216.782412615627;6225.533085018642;6333.018382150774;6350.936490635035;398.7687141457947;408.7772164170534;409.28171059790475;409.7500524679943;411.2699957575328;4755.857324280277;4833.347498087714;4845.49122342149;4874.561289483963;4881;7426.480146389701;7787.10448298453;7797.337226335825;7866.72466463671;7910.9604451977375;7648.34989025939;7652.120006199247;7658.425618078666;7683.1548529661695;7756.612169391507;5549.722513874371;5806.361300256968;6131.540134489931;6164.198654175018;6196.287426945869;6072.423119803611;6220.129181914626;6223.190985171898;6283.2460104787715;6335.461485773761;6837.3162683731225;6908.965455172893;7085;7095.219525852049;7105.928940710527;7051.471139664648;7196.96401517989;7289.890651640124;7316.1952185258515;7446.032015837906;5810.837832433445;5879.823605291848;5934.43622855828;5959.22530071088;5968.432998865101;6358.682065896779;6382.904256436064;6392.169018027813;6422.197225346832;6446.323136070832;5871.941280587311;5934.495567876779;5968.46283834457;6064.969675151596;6105.572609917263;5863.472287494146;5903.203067585821;5905.970470147794;5944.6730429826775;5974.940250597612;5966.343702192842;6006.849828754316;6013.849653758691;6021.307549631849;6033.547483938634;5351.464853514617;5378.19327100938;5422.810201642924;5431.103867861759;5505.752241149078;4812.278158276286;4943.65394422387;5396.3524377075;5473.698946557818;5547.583931205257 21:33:05 INFO - 2015-11-15 21:33:05,988 DEBUG : BROWSER_OUTPUT: |4;prototype.html;259.4512605838651;261.49792398594695;266.9452762183752;268.55554058033954;271.17021912946376;5127.871803204922;5200.713960732158;5243.973780131094;5305.575553955679;5358.946410535894;5034.521720436553;5179;5186.247994040862;5221.295125158112;5295.894082118355;3967.761934283952;3995.12107336387;4011.2980228460046;4014.8193331300017;4050.696197785178;3988.24223397555;4037.454943582623;4045.7774822384904;4047.494063242095;4060.2894493463527;3865.323568375537;3940.822662980173;3956.188981258835;4016.3975403689387;4021.4772079629606;3919.9216015679526;3971.721979461439;3974.4435778990965;3979.621935916083;3989.4215338775716;3414.709749671281;3428.674275943781;3432.7768695034742;3433.8626454941773;3447.258839349552;4837.443693975168;5007.92488112675;5023.673461225008;5135.845924622267;5143.819966301199;4466.843660471868;4469.08383781324;4474.619657329131;4504.1892459357305;4553.704009239389;5447.5914306426785;5455.454454554552;5464.562834973192;5536.4186760390385;5545.861353466155;3697.2605478904325;3698.4082546792383;3707.3141468828353;3720.6093360197333;3740.121071548184;5610.775568977236;5626.662400255997;5674.233978412903;5698.686572238566;5802.738876750556;3769.453429252743;3778.7354885157774;3780.092777733379;3805.82873770681;3837.6929845612285;3859.363205071188;3864.8019114074727;3868.6518213360932;3876.341022026262;3895.941560876589;4443.37792709021;4447.199504089295;4447.73313601185;4464.241079016575;4517.028838799608;5213.7914483421;5251.842444726664;5421.5933804964;5431.891362172734;5488.9725551371985;1322.3520474967388;1355.6339788257114;1360.4762166565943;1366.3441548056987;1368.1722557852554;881.7883707910055;887.1040249348076;896.8340856941487;906.7687739626354;907.0702529906766;5196.792128314901;5204.297419848348;5223.555997740159;5253.763580638881;5264.394594621591;5645.717714114277;5651.124075768263;5676.290463692038;5734.4838964492565;5735.0250457422335;5225.268462415265;5228.398734145546;5235.973820130951;5309.7079660618265;5313.521783039545;2960.304328482805;3026.3493348930087;3060.234941264684;3065.157081802522;3114.1280441476424;5813.680247586339;5870.559708021916;5882.205902203234;5916.437938395846;5933.258342707161;5819.82540523785;5825.679587622637;5841.707914604252;5851.444112809277;5868.178455016301;5677.205191273308;5804.390538993429;5824.650520968671;5905.822825315161;5921;5608.46719561641;5634.126710359901;5667.603267771216;5691.4877661010705;5694.629849059798;5459.962607104638;5502.972485137709;5555.2222688822785;5562.193481945176;5566.276384070045;5760.222369979999;5830.883382332415;5850.356460789225;5904.988455887443;5908.202392676933;3694.6674799268194;3791.279656865187;3808.847646094125;3868.032991752062;3873;5499.477549632778;5581.358143813513;5584.46947539983;5691.288588926384;5703.058995265735;5362.758675859518;5492.066348720807;5530.087535556588;5614.382417934105;5617.382087970402;5526.806561770319;5548.278723765885;5588.3573389060775;5604.383517812956;5610.102383618601;5235.3717553893775;5390.676559406448;5439;5475.206095116266;5491.121420572689;5518.392976772632;5540.307461567304;5584.078627026495;5610.438956104357;5621.690807005654;5412.890357476786;5418.268533748052;5482.506574408322;5484.341878974548;5504.6421982571 21:33:05 INFO - 2015-11-15 21:33:05,992 DEBUG : BROWSER_OUTPUT: |5;yui.html;589.9439553242444;597.2176448852005;622.6917675750504;625.4277336237342;627.8838414893243;10108.646197383094;11026.724331891706;11078.446077696102;11298.717532061703;11304.152188585847;10493.737656558571;10493.895061049407;10564.471776411187;10687;10712.357258564492;576.7837061102086;586.7330364684059;713.9357457828794;721.700494294867;729.7810656802965;722.241646271413;727.6180005497104;738.6122285799944;748.7529115391908;752.9322360987537;748.8090536913106;767.5624893810502;768.561919705768;768.6656304507529;780.4809801482036;751.3087959077661;752.9134149572787;762.1007211490439;763.522798251093;773.5938632218074;549.5493695169962;550.1747378931602;551.0246863052415;559.5132234955614;559.6362364463091;11078.889211107866;11207.66377008691;11234.382108984002;11237.213395062348;11437.542498300058;8724.127587241288;9189.44863308197;9361.578728957213;9412.529373531295;10294.279400441972;7369.668364923537;7517.4737768356235;7595.126560445564;7834;7982.880256796153;2424.2969538833718;2496.962545561818;2549.0823303610687;2554.7189809120982;2842.0905310300714;35130.121746956276;35934.46098308502;36456.088597785005;36514.63485365139;36714;5505.119180931032;5518;5606.887862242732;5697.772089116472;5793.94206057934;9597.184239339595;9685.854712179324;9687.612495500241;9801.705948821547;9894.15899648538;4959.752012399365;4979.850604481871;5025.020121076428;5035.093683137071;5056.6207534434325;2902.912912612625;2908.6073380093417;2961.2744877505147;3022.652394974562;3103.1466346754373;2115.756687980871;2159.29822807585;2165.750938642076;2169.945751356229;2170.392290158758;326.24311597094515;331.8821818254533;332.6706560505131;333.1853617904201;334.0196523204403;369.52700543304616;463.367503357914;479.31936649957146;496.9826056088092;503.4587818095489;6336.398042186077;6583.518708290692;6598.802035938834;6748.662566871637;6781.728730850711;349.3101125277557;417.8098964970931;486.8977514721948;496.85839535732146;502.68330951501054;3111.8132912025353;3136.090533745234;3161.3993341265086;3193.728533074668;3218.8873389431255;47860.5213947863;48227.276590851165;48262.51737482651;48562.27156592654;48766.512334876905;40098.19803603912;40528.797356013034;40777.38833917493;40901.795491022356;41254.38118428226;36152;36416.635833641856;36726.449103263476;37398.62601374006;38195;6297;6347.206599175103;6464.644444555406;6483.286838447862;6505.902411463737;28268.85865570659;28859.278518037216;28950.42099158047;29019.564706528996;29140.562891557067;34395.65604344025;34482.41381896418;36965;37326.626733732315;37574.62425375821;5866.2373891393845;5973.014452615444;5998.640081595118;6107.328193898757;6299.559030867796;8152.755417337489;8341.708040218806;8419.452735572168;8469.830603388022;8556.401051926305;7923.762287131395;7990.453223280351;8047.879281810895;8097.068837083811;8108.554029528433;7862.007257543326;7897.170797066455;7947.642356093874;8009.639566219417;8014.358851292;7787.844243115219;7809.804754881174;8134.023917129983;8164.346852251924;8382.622781974947;6859.5541289818;6928.309576370124;7096.7516136934955;7385.96307018483;7477.513961592479;6695.531312808252;7054.576725396492;7262.128544574685;7272.854542909218;7277.235890231449 21:33:05 INFO - 2015-11-15 21:33:05,992 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:33:05 INFO - 2015-11-15 21:33:05,993 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:33:05 INFO - 2015-11-15 21:33:05,993 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,307 21:33:05 INFO - 2015-11-15 21:33:05,993 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:33:05 INFO - 2015-11-15 21:33:05,993 DEBUG : BROWSER_OUTPUT: __startTimestamp1447651985975__endTimestamp 21:33:05 INFO - 2015-11-15 21:33:05,993 DEBUG : BROWSER_OUTPUT: 21:33:05 INFO - 2015-11-15 21:33:05,993 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:33:05 INFO - 2015-11-15 21:33:05,994 DEBUG : BROWSER_OUTPUT: Number of tests: 6 21:33:05 INFO - 2015-11-15 21:33:05,994 DEBUG : BROWSER_OUTPUT: 21:33:05 INFO - 2015-11-15 21:33:05,994 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4398.59 Median:4536.09 stddev:583.04 (12.9%) stddev-sans-first:566.41 21:33:05 INFO - 2015-11-15 21:33:05,994 DEBUG : BROWSER_OUTPUT: Values: 2545.2 2610.1 2676.5 2677.2 2688.9 4277.1 4355.3 4475.8 4483.0 4536.1 4218.7 4356.0 4361.3 4389.1 4498.3 4092.8 4100.7 4133.4 4135.9 4167.6 220.2 4110.9 4203.2 4224.7 4241.0 4022.5 4047.0 4081.8 4106.6 4138.3 4115.2 4132.6 4136.2 4195.9 4233.1 3935.3 4044.0 4095.7 4133.5 4150.3 4149.5 4260.4 4311.7 4412.0 4466.4 4651.1 4679.4 4739.1 4752.1 4828.3 4702.2 4746.7 4750.0 4791.9 4794.5 4461.9 4470.1 4473.4 4500.7 4525.6 4891.9 4896.8 4926.5 4949.0 4979.3 4411.8 4467.1 4592.8 4608.1 4689.8 4703.7 4761.4 4784.4 4806.3 4844.6 4640.5 4679.2 4709.0 4716.7 4753.0 4494.4 4575.8 4607.6 4685.3 4720.4 3619.2 3620.8 3646.0 3674.2 3680.0 3265.2 3320.0 3335.8 3369.1 3376.4 4359.1 4398.1 4414.7 4427.2 4524.2 4818.2 4822.4 4835.2 4843.7 4883.9 4291.3 4426.4 4453.8 4510.6 4558.2 4064.2 4084.9 4101.1 4157.3 4160.5 4897.7 4918.3 4932.0 4933.6 5027.7 4657.2 4714.6 4773.5 4841.5 4881.0 4954.5 4963.3 4963.5 5024.8 5075.6 4710.8 4718.4 4738.4 4742.5 4767.2 4643.9 4676.9 4746.5 4788.8 4862.9 4609.5 4644.1 4651.1 4691.5 4696.8 4642.8 4650.8 4651.4 4653.9 4735.0 4443.4 4492.2 4503.4 4514.7 4614.2 4517.7 4566.8 4579.8 4582.1 4695.0 4405.4 4590.5 4614.3 4647.6 4666.9 21:33:05 INFO - 2015-11-15 21:33:05,994 DEBUG : BROWSER_OUTPUT: 21:33:05 INFO - 2015-11-15 21:33:05,995 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:39856.58 Median:33855.33 stddev:69125.44 (204.2%) stddev-sans-first:69256.00 21:33:05 INFO - 2015-11-15 21:33:05,995 DEBUG : BROWSER_OUTPUT: Values: 439.9 454.5 459.0 478.8 497.3 32704.0 33427.7 33691.8 34357.1 34426.3 35164.8 35565.5 35839.0 36175.0 36217.3 7588.0 7724.8 7826.0 7857.3 7883.2 7497.9 7541.9 7568.9 7605.0 7677.2 7586.5 7676.9 7684.3 7700.2 7734.5 7438.7 7524.7 7584.8 7628.0 7638.7 7474.8 7612.8 7687.1 7696.1 7755.5 33389.8 33420.7 33440.8 34018.8 34165.7 2041.1 2239.4 2280.4 2528.4 3092.6 21862.3 22535.3 23039.7 23232.2 23716.8 1905.2 1907.0 1947.2 1961.0 1962.4 203801.0 205261.0 205389.0 207569.0 208708.0 36892.3 49202.3 49588.3 50061.7 50503.7 37188.4 37241.0 37251.3 37257.4 37811.2 11197.3 11340.2 11346.0 11387.7 11450.5 8731.6 8779.6 8795.9 8820.9 8916.6 11807.6 11880.3 11896.6 11981.8 12053.5 5085.5 5186.7 5197.9 5204.7 5211.5 825.5 830.4 855.3 878.9 879.6 23907.2 24067.4 24281.3 24340.9 24378.1 843.4 847.9 871.7 888.8 894.8 12349.4 12398.8 12424.2 12452.4 12583.1 329835.0 331797.0 333689.0 334893.0 335034.0 48250.8 48841.5 48896.3 49213.8 49255.5 1107.5 1107.5 1119.5 1123.6 1140.5 23766.8 26942.0 27247.0 27266.0 27454.5 43040.8 43848.3 44553.0 44564.8 44646.0 228823.0 230921.0 232651.0 233706.0 234986.0 35256.6 35314.1 37108.8 38641.4 38803.2 35594.0 36035.3 36264.5 36673.1 37413.4 30138.8 30914.5 31022.0 31054.5 31190.7 30114.7 30361.8 30402.1 30431.7 32400.5 30610.7 30629.5 31132.5 31237.8 31478.4 25414.2 26959.2 27082.2 27239.7 27458.2 20285.6 20443.3 20458.4 20597.0 20725.2 21:33:05 INFO - 2015-11-15 21:33:05,995 DEBUG : BROWSER_OUTPUT: 21:33:05 INFO - 2015-11-15 21:33:05,995 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23132.00 Median:5045.43 stddev:71579.28 (1418.7%) stddev-sans-first:71759.50 21:33:05 INFO - 2015-11-15 21:33:05,997 DEBUG : BROWSER_OUTPUT: Values: 275.2 275.4 279.4 280.4 284.0 11658.5 14204.7 14505.9 14517.9 14944.9 13986.2 14259.5 15755.0 16388.9 16445.9 4797.4 4957.9 5035.5 5055.4 5132.8 5034.9 5115.0 5123.1 5142.1 5144.3 4760.1 5105.4 5263.6 5565.0 5582.6 5535.3 5573.9 5588.9 5605.7 5650.5 5211.6 5347.2 5437.9 5442.0 5484.9 14655.6 15023.5 15061.9 17859.9 18269.4 1642.7 1689.6 1715.6 1716.6 1792.8 11579.9 11724.9 11974.2 12232.8 12486.2 1460.4 1480.8 1486.8 1491.6 1492.8 42096.2 44060.9 48326.5 48875.0 55693.7 13560.6 14176.6 14460.3 14465.4 14486.8 20339.0 20402.8 20437.8 20699.2 20825.6 7298.6 7328.2 7421.7 7625.8 7631.2 5999.9 6108.7 6131.5 6380.8 6515.4 6722.3 6869.9 6899.9 6941.7 6947.1 2783.6 2793.5 2809.8 2812.5 2819.8 333.3 343.8 348.9 356.7 357.9 8851.3 9345.0 9346.1 9365.1 9653.5 380.7 387.2 388.4 397.3 409.2 4857.2 4906.1 5181.8 5203.2 5222.0 425826.0 434921.0 435275.0 442920.0 454663.0 55557.2 56180.4 56929.4 57688.1 58215.0 418.7 419.4 420.9 422.4 425.3 8526.2 8541.1 8612.8 8672.3 8710.5 26777.5 27191.9 27329.9 27651.6 28040.3 37438.3 37758.6 37949.6 38110.0 38635.2 6344.7 6384.5 6488.4 6550.3 6564.8 9460.5 9622.3 9631.9 9761.2 9929.3 6919.5 7344.4 8104.0 8284.5 8489.7 6791.8 7748.8 7831.9 8090.6 8264.5 8137.1 8142.8 8203.7 8417.0 8466.0 6160.4 6254.1 6264.2 6350.8 6374.2 8002.2 8024.4 8031.2 8043.3 8077.5 21:33:05 INFO - 2015-11-15 21:33:05,997 DEBUG : BROWSER_OUTPUT: 21:33:05 INFO - 2015-11-15 21:33:05,997 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4577.72 Median:5526.67 stddev:2363.39 (42.8%) stddev-sans-first:2358.30 21:33:05 INFO - 2015-11-15 21:33:05,997 DEBUG : BROWSER_OUTPUT: Values: 1445.6 1453.4 1463.8 1494.9 1528.0 5279.3 5465.9 5476.2 5866.6 6156.9 6391.4 6438.1 6595.8 6606.4 6629.4 1866.5 1899.4 1902.6 1906.6 1907.0 1909.6 1953.3 1956.2 1959.9 1994.6 1892.6 1924.7 1924.9 1955.5 1957.9 1803.6 1857.9 1861.7 1889.8 1893.0 1861.9 1873.2 1875.4 1882.7 1945.5 6574.8 6661.7 6735.4 6761.0 6796.6 3985.3 4075.5 4078.9 4104.2 4146.6 2184.2 2236.1 2360.6 2464.0 2499.3 736.2 744.9 748.5 752.4 773.5 8500.8 8739.7 8783.6 8899.3 8901.9 3776.8 3788.5 3827.4 3844.8 3918.6 7568.2 7582.0 7605.7 7646.9 7693.6 4138.8 4138.9 4171.5 4172.4 4233.5 3755.5 3757.5 3764.5 3768.4 3823.3 3146.1 3160.1 3192.2 3199.7 3224.7 995.6 1001.5 1002.2 1002.3 1027.0 1047.8 1077.0 1092.1 1107.4 1109.4 6179.8 6216.8 6225.5 6333.0 6350.9 398.8 408.8 409.3 409.8 411.3 4755.9 4833.3 4845.5 4874.6 4881.0 7426.5 7787.1 7797.3 7866.7 7911.0 7648.3 7652.1 7658.4 7683.2 7756.6 5549.7 5806.4 6131.5 6164.2 6196.3 6072.4 6220.1 6223.2 6283.2 6335.5 6837.3 6909.0 7085.0 7095.2 7105.9 7051.5 7197.0 7289.9 7316.2 7446.0 5810.8 5879.8 5934.4 5959.2 5968.4 6358.7 6382.9 6392.2 6422.2 6446.3 5871.9 5934.5 5968.5 6065.0 6105.6 5863.5 5903.2 5906.0 5944.7 5974.9 5966.3 6006.8 6013.8 6021.3 6033.5 5351.5 5378.2 5422.8 5431.1 5505.8 4812.3 4943.7 5396.4 5473.7 5547.6 21:33:06 INFO - 2015-11-15 21:33:05,998 DEBUG : BROWSER_OUTPUT: 21:33:06 INFO - 2015-11-15 21:33:05,999 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4584.06 Median:5252.80 stddev:1397.74 (26.6%) stddev-sans-first:1363.45 21:33:06 INFO - 2015-11-15 21:33:06,000 DEBUG : BROWSER_OUTPUT: Values: 259.5 261.5 266.9 268.6 271.2 5127.9 5200.7 5244.0 5305.6 5358.9 5034.5 5179.0 5186.2 5221.3 5295.9 3967.8 3995.1 4011.3 4014.8 4050.7 3988.2 4037.5 4045.8 4047.5 4060.3 3865.3 3940.8 3956.2 4016.4 4021.5 3919.9 3971.7 3974.4 3979.6 3989.4 3414.7 3428.7 3432.8 3433.9 3447.3 4837.4 5007.9 5023.7 5135.8 5143.8 4466.8 4469.1 4474.6 4504.2 4553.7 5447.6 5455.5 5464.6 5536.4 5545.9 3697.3 3698.4 3707.3 3720.6 3740.1 5610.8 5626.7 5674.2 5698.7 5802.7 3769.5 3778.7 3780.1 3805.8 3837.7 3859.4 3864.8 3868.7 3876.3 3895.9 4443.4 4447.2 4447.7 4464.2 4517.0 5213.8 5251.8 5421.6 5431.9 5489.0 1322.4 1355.6 1360.5 1366.3 1368.2 881.8 887.1 896.8 906.8 907.1 5196.8 5204.3 5223.6 5253.8 5264.4 5645.7 5651.1 5676.3 5734.5 5735.0 5225.3 5228.4 5236.0 5309.7 5313.5 2960.3 3026.3 3060.2 3065.2 3114.1 5813.7 5870.6 5882.2 5916.4 5933.3 5819.8 5825.7 5841.7 5851.4 5868.2 5677.2 5804.4 5824.7 5905.8 5921.0 5608.5 5634.1 5667.6 5691.5 5694.6 5460.0 5503.0 5555.2 5562.2 5566.3 5760.2 5830.9 5850.4 5905.0 5908.2 3694.7 3791.3 3808.8 3868.0 3873.0 5499.5 5581.4 5584.5 5691.3 5703.1 5362.8 5492.1 5530.1 5614.4 5617.4 5526.8 5548.3 5588.4 5604.4 5610.1 5235.4 5390.7 5439.0 5475.2 5491.1 5518.4 5540.3 5584.1 5610.4 5621.7 5412.9 5418.3 5482.5 5484.3 5504.6 21:33:06 INFO - 2015-11-15 21:33:06,000 DEBUG : BROWSER_OUTPUT: 21:33:06 INFO - 2015-11-15 21:33:06,001 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10538.07 Median:3038.76 stddev:12935.04 (425.7%) stddev-sans-first:12949.76 21:33:06 INFO - 2015-11-15 21:33:06,001 DEBUG : BROWSER_OUTPUT: Values: 589.9 597.2 622.7 625.4 627.9 10108.6 11026.7 11078.4 11298.7 11304.2 10493.7 10493.9 10564.5 10687.0 10712.4 576.8 586.7 713.9 721.7 729.8 722.2 727.6 738.6 748.8 752.9 748.8 767.6 768.6 768.7 780.5 751.3 752.9 762.1 763.5 773.6 549.5 550.2 551.0 559.5 559.6 11078.9 11207.7 11234.4 11237.2 11437.5 8724.1 9189.4 9361.6 9412.5 10294.3 7369.7 7517.5 7595.1 7834.0 7982.9 2424.3 2497.0 2549.1 2554.7 2842.1 35130.1 35934.5 36456.1 36514.6 36714.0 5505.1 5518.0 5606.9 5697.8 5793.9 9597.2 9685.9 9687.6 9801.7 9894.2 4959.8 4979.9 5025.0 5035.1 5056.6 2902.9 2908.6 2961.3 3022.7 3103.1 2115.8 2159.3 2165.8 2169.9 2170.4 326.2 331.9 332.7 333.2 334.0 369.5 463.4 479.3 497.0 503.5 6336.4 6583.5 6598.8 6748.7 6781.7 349.3 417.8 486.9 496.9 502.7 3111.8 3136.1 3161.4 3193.7 3218.9 47860.5 48227.3 48262.5 48562.3 48766.5 40098.2 40528.8 40777.4 40901.8 41254.4 36152.0 36416.6 36726.4 37398.6 38195.0 6297.0 6347.2 6464.6 6483.3 6505.9 28268.9 28859.3 28950.4 29019.6 29140.6 34395.7 34482.4 36965.0 37326.6 37574.6 5866.2 5973.0 5998.6 6107.3 6299.6 8152.8 8341.7 8419.5 8469.8 8556.4 7923.8 7990.5 8047.9 8097.1 8108.6 7862.0 7897.2 7947.6 8009.6 8014.4 7787.8 7809.8 8134.0 8164.3 8382.6 6859.6 6928.3 7096.8 7386.0 7477.5 6695.5 7054.6 7262.1 7272.9 7277.2 21:33:06 INFO - 2015-11-15 21:33:06,001 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:33:06 INFO - 2015-11-15 21:33:06,001 DEBUG : BROWSER_OUTPUT: 21:33:06 INFO - 2015-11-15 21:33:06,668 INFO : Browser exited with error code: 0 21:33:06 INFO - 2015-11-15 21:33:06,702 INFO : Completed test dromaeo_css (00:18:31) 21:33:06 INFO - 2015-11-15 21:33:06,702 INFO : Starting test kraken 21:33:06 INFO - 2015-11-15 21:33:06,702 DEBUG : operating with platform_type : mac_ 21:33:06 INFO - 2015-11-15 21:33:06,703 INFO : Initialising browser for kraken test... 21:33:06 INFO - 2015-11-15 21:33:06,719 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/tmpUTyjMg/profile http://localhost:50138/getInfo.html 21:33:10 INFO - 2015-11-15 21:33:10,092 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:33:10 INFO - 2015-11-15 21:33:10,092 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:33:10 INFO - 2015-11-15 21:33:10,092 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 21:33:10 INFO - 2015-11-15 21:33:10,092 DEBUG : BROWSER_OUTPUT: __metrics 21:33:10 INFO - 2015-11-15 21:33:10,845 INFO : Browser initialized. 21:33:10 INFO - 2015-11-15 21:33:10,845 INFO : Running cycle 1/1 for kraken test... 21:33:10 INFO - 2015-11-15 21:33:10,845 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/tmpUTyjMg/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:33:23 INFO - 2015-11-15 21:33:23,112 DEBUG : BROWSER_OUTPUT: RSS: Main: 241573888 21:33:23 INFO - 2015-11-15 21:33:23,112 DEBUG : BROWSER_OUTPUT: 21:33:26 INFO - 2015-11-15 21:33:26,080 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:50138/tests/kraken/driver.html?testName=audio-beat-detection) 21:33:26 INFO - 2015-11-15 21:33:26,691 DEBUG : BROWSER_OUTPUT: RSS: Main: 259248128 21:33:26 INFO - 2015-11-15 21:33:26,691 DEBUG : BROWSER_OUTPUT: 21:33:29 INFO - 2015-11-15 21:33:29,854 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:50138/tests/kraken/driver.html?testName=audio-dft) 21:33:30 INFO - 2015-11-15 21:33:30,462 DEBUG : BROWSER_OUTPUT: RSS: Main: 266776576 21:33:30 INFO - 2015-11-15 21:33:30,462 DEBUG : BROWSER_OUTPUT: 21:33:33 INFO - 2015-11-15 21:33:33,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:50138/tests/kraken/driver.html?testName=audio-fft) 21:33:34 INFO - 2015-11-15 21:33:34,476 DEBUG : BROWSER_OUTPUT: RSS: Main: 268009472 21:33:34 INFO - 2015-11-15 21:33:34,476 DEBUG : BROWSER_OUTPUT: 21:33:36 INFO - 2015-11-15 21:33:36,704 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:50138/tests/kraken/driver.html?testName=audio-oscillator) 21:33:37 INFO - 2015-11-15 21:33:37,306 DEBUG : BROWSER_OUTPUT: RSS: Main: 268005376 21:33:37 INFO - 2015-11-15 21:33:37,306 DEBUG : BROWSER_OUTPUT: 21:33:39 INFO - 2015-11-15 21:33:39,763 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:50138/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:33:40 INFO - 2015-11-15 21:33:40,348 DEBUG : BROWSER_OUTPUT: RSS: Main: 268763136 21:33:40 INFO - 2015-11-15 21:33:40,349 DEBUG : BROWSER_OUTPUT: 21:33:43 INFO - 2015-11-15 21:33:43,960 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:50138/tests/kraken/driver.html?testName=imaging-darkroom) 21:33:44 INFO - 2015-11-15 21:33:44,549 DEBUG : BROWSER_OUTPUT: RSS: Main: 266960896 21:33:44 INFO - 2015-11-15 21:33:44,549 DEBUG : BROWSER_OUTPUT: 21:33:48 INFO - 2015-11-15 21:33:48,289 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:50138/tests/kraken/driver.html?testName=imaging-desaturate) 21:33:48 INFO - 2015-11-15 21:33:48,882 DEBUG : BROWSER_OUTPUT: RSS: Main: 268017664 21:33:48 INFO - 2015-11-15 21:33:48,882 DEBUG : BROWSER_OUTPUT: 21:33:52 INFO - 2015-11-15 21:33:52,252 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:50138/tests/kraken/driver.html?testName=json-parse-financial) 21:33:52 INFO - 2015-11-15 21:33:52,847 DEBUG : BROWSER_OUTPUT: RSS: Main: 267628544 21:33:52 INFO - 2015-11-15 21:33:52,847 DEBUG : BROWSER_OUTPUT: 21:33:54 INFO - 2015-11-15 21:33:54,645 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:50138/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:33:55 INFO - 2015-11-15 21:33:55,225 DEBUG : BROWSER_OUTPUT: RSS: Main: 266919936 21:33:55 INFO - 2015-11-15 21:33:55,225 DEBUG : BROWSER_OUTPUT: 21:33:57 INFO - 2015-11-15 21:33:57,347 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:50138/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:33:57 INFO - 2015-11-15 21:33:57,995 DEBUG : BROWSER_OUTPUT: RSS: Main: 267362304 21:33:57 INFO - 2015-11-15 21:33:57,995 DEBUG : BROWSER_OUTPUT: 21:34:00 INFO - 2015-11-15 21:34:00,419 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:50138/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:34:01 INFO - 2015-11-15 21:34:01,010 DEBUG : BROWSER_OUTPUT: RSS: Main: 267177984 21:34:01 INFO - 2015-11-15 21:34:01,010 DEBUG : BROWSER_OUTPUT: 21:34:04 INFO - 2015-11-15 21:34:04,108 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:50138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:34:04 INFO - 2015-11-15 21:34:04,717 DEBUG : BROWSER_OUTPUT: RSS: Main: 267862016 21:34:04 INFO - 2015-11-15 21:34:04,717 DEBUG : BROWSER_OUTPUT: 21:34:07 INFO - 2015-11-15 21:34:07,847 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:50138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:34:08 INFO - 2015-11-15 21:34:08,441 DEBUG : BROWSER_OUTPUT: RSS: Main: 269213696 21:34:08 INFO - 2015-11-15 21:34:08,441 DEBUG : BROWSER_OUTPUT: 21:34:10 INFO - 2015-11-15 21:34:10,398 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:50138/tests/kraken/driver.html?testName=ai-astar) 21:34:10 INFO - 2015-11-15 21:34:10,647 DEBUG : BROWSER_OUTPUT: RSS: Main: 269135872 21:34:10 INFO - 2015-11-15 21:34:10,648 DEBUG : BROWSER_OUTPUT: 21:34:10 INFO - 2015-11-15 21:34:10,648 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:34:10 INFO - 2015-11-15 21:34:10,648 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:34:10 INFO - 2015-11-15 21:34:10,648 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:34:10 INFO - 2015-11-15 21:34:10,648 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:34:10 INFO - 2015-11-15 21:34:10,649 DEBUG : BROWSER_OUTPUT: |0;ai-astar;133;129;140;140;140;155;140;141;140;138 21:34:10 INFO - 2015-11-15 21:34:10,649 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;206;171;193;207;164;189;197;175;207;169 21:34:10 INFO - 2015-11-15 21:34:10,649 DEBUG : BROWSER_OUTPUT: |2;audio-dft;215;207;209;213;212;214;211;211;214;210 21:34:10 INFO - 2015-11-15 21:34:10,649 DEBUG : BROWSER_OUTPUT: |3;audio-fft;85;91;105;156;85;89;89;89;128;84 21:34:10 INFO - 2015-11-15 21:34:10,650 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;107;109;161;112;114;114;156;114;114;161 21:34:10 INFO - 2015-11-15 21:34:10,650 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;156;149;149;156;157;157;155;149;157;149 21:34:10 INFO - 2015-11-15 21:34:10,650 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;164;164;165;165;164;164;164;165;167;163 21:34:10 INFO - 2015-11-15 21:34:10,650 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;123;136;124;134;126;130;126;124;124;137 21:34:10 INFO - 2015-11-15 21:34:10,650 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;77;78;81;83;82;81;90;82;83 21:34:10 INFO - 2015-11-15 21:34:10,651 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;85;88;90;93;92;94;94;94;94;95 21:34:10 INFO - 2015-11-15 21:34:10,651 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;107;111;113;110;112;111;111;111;112;112 21:34:10 INFO - 2015-11-15 21:34:10,651 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;161;169;170;183;162;162;174;173;173;170 21:34:10 INFO - 2015-11-15 21:34:10,651 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;190;202;201;202;201;198;192;198;203;190 21:34:10 INFO - 2015-11-15 21:34:10,651 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;83;87;89;92;90;92;91;90;91;92 21:34:10 INFO - 2015-11-15 21:34:10,651 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:34:10 INFO - 2015-11-15 21:34:10,653 DEBUG : BROWSER_OUTPUT: __start_cc_report 21:34:10 INFO - 2015-11-15 21:34:10,653 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,768 21:34:10 INFO - 2015-11-15 21:34:10,653 DEBUG : BROWSER_OUTPUT: __end_cc_report 21:34:10 INFO - 2015-11-15 21:34:10,653 DEBUG : BROWSER_OUTPUT: __startTimestamp1447652050647__endTimestamp 21:34:10 INFO - 2015-11-15 21:34:10,654 DEBUG : BROWSER_OUTPUT: 21:34:10 INFO - 2015-11-15 21:34:10,654 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:34:10 INFO - 2015-11-15 21:34:10,654 DEBUG : BROWSER_OUTPUT: Number of tests: 14 21:34:10 INFO - 2015-11-15 21:34:10,654 DEBUG : BROWSER_OUTPUT: 21:34:10 INFO - 2015-11-15 21:34:10,654 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:139.60 Median:140.00 stddev:6.65 (4.8%) stddev-sans-first:6.61 21:34:10 INFO - 2015-11-15 21:34:10,654 DEBUG : BROWSER_OUTPUT: Values: 133.0 129.0 140.0 140.0 140.0 155.0 140.0 141.0 140.0 138.0 21:34:10 INFO - 2015-11-15 21:34:10,655 DEBUG : BROWSER_OUTPUT: 21:34:10 INFO - 2015-11-15 21:34:10,655 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:187.80 Median:195.00 stddev:16.82 (8.6%) stddev-sans-first:16.51 21:34:10 INFO - 2015-11-15 21:34:10,655 DEBUG : BROWSER_OUTPUT: Values: 206.0 171.0 193.0 207.0 164.0 189.0 197.0 175.0 207.0 169.0 21:34:10 INFO - 2015-11-15 21:34:10,655 DEBUG : BROWSER_OUTPUT: 21:34:10 INFO - 2015-11-15 21:34:10,655 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:211.60 Median:212.50 stddev:2.50 (1.2%) stddev-sans-first:2.33 21:34:10 INFO - 2015-11-15 21:34:10,655 DEBUG : BROWSER_OUTPUT: Values: 215.0 207.0 209.0 213.0 212.0 214.0 211.0 211.0 214.0 210.0 21:34:10 INFO - 2015-11-15 21:34:10,656 DEBUG : BROWSER_OUTPUT: 21:34:10 INFO - 2015-11-15 21:34:10,656 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:100.10 Median:87.00 stddev:23.79 (27.3%) stddev-sans-first:24.60 21:34:10 INFO - 2015-11-15 21:34:10,657 DEBUG : BROWSER_OUTPUT: Values: 85.0 91.0 105.0 156.0 85.0 89.0 89.0 89.0 128.0 84.0 21:34:10 INFO - 2015-11-15 21:34:10,657 DEBUG : BROWSER_OUTPUT: 21:34:10 INFO - 2015-11-15 21:34:10,657 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:126.20 Median:114.00 stddev:23.03 (20.2%) stddev-sans-first:23.35 21:34:10 INFO - 2015-11-15 21:34:10,658 DEBUG : BROWSER_OUTPUT: Values: 107.0 109.0 161.0 112.0 114.0 114.0 156.0 114.0 114.0 161.0 21:34:10 INFO - 2015-11-15 21:34:10,658 DEBUG : BROWSER_OUTPUT: 21:34:10 INFO - 2015-11-15 21:34:10,658 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:153.40 Median:156.00 stddev:3.84 (2.5%) stddev-sans-first:3.95 21:34:10 INFO - 2015-11-15 21:34:10,658 DEBUG : BROWSER_OUTPUT: Values: 156.0 149.0 149.0 156.0 157.0 157.0 155.0 149.0 157.0 149.0 21:34:10 INFO - 2015-11-15 21:34:10,658 DEBUG : BROWSER_OUTPUT: 21:34:10 INFO - 2015-11-15 21:34:10,658 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:164.50 Median:164.50 stddev:1.08 (0.7%) stddev-sans-first:1.13 21:34:10 INFO - 2015-11-15 21:34:10,658 DEBUG : BROWSER_OUTPUT: Values: 164.0 164.0 165.0 165.0 164.0 164.0 164.0 165.0 167.0 163.0 21:34:10 INFO - 2015-11-15 21:34:10,659 DEBUG : BROWSER_OUTPUT: 21:34:10 INFO - 2015-11-15 21:34:10,659 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:128.40 Median:128.00 stddev:5.42 (4.2%) stddev-sans-first:5.39 21:34:10 INFO - 2015-11-15 21:34:10,659 DEBUG : BROWSER_OUTPUT: Values: 123.0 136.0 124.0 134.0 126.0 130.0 126.0 124.0 124.0 137.0 21:34:10 INFO - 2015-11-15 21:34:10,659 DEBUG : BROWSER_OUTPUT: 21:34:10 INFO - 2015-11-15 21:34:10,659 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:81.00 Median:82.00 stddev:4.47 (5.5%) stddev-sans-first:3.69 21:34:10 INFO - 2015-11-15 21:34:10,660 DEBUG : BROWSER_OUTPUT: Values: 73.0 77.0 78.0 81.0 83.0 82.0 81.0 90.0 82.0 83.0 21:34:10 INFO - 2015-11-15 21:34:10,660 DEBUG : BROWSER_OUTPUT: 21:34:10 INFO - 2015-11-15 21:34:10,660 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:91.90 Median:94.00 stddev:3.25 (3.5%) stddev-sans-first:2.29 21:34:10 INFO - 2015-11-15 21:34:10,660 DEBUG : BROWSER_OUTPUT: Values: 85.0 88.0 90.0 93.0 92.0 94.0 94.0 94.0 94.0 95.0 21:34:10 INFO - 2015-11-15 21:34:10,661 DEBUG : BROWSER_OUTPUT: 21:34:10 INFO - 2015-11-15 21:34:10,661 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:111.00 Median:111.50 stddev:1.63 (1.5%) stddev-sans-first:0.88 21:34:10 INFO - 2015-11-15 21:34:10,661 DEBUG : BROWSER_OUTPUT: Values: 107.0 111.0 113.0 110.0 112.0 111.0 111.0 111.0 112.0 112.0 21:34:10 INFO - 2015-11-15 21:34:10,661 DEBUG : BROWSER_OUTPUT: 21:34:10 INFO - 2015-11-15 21:34:10,661 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:169.70 Median:171.50 stddev:6.77 (3.9%) stddev-sans-first:6.40 21:34:10 INFO - 2015-11-15 21:34:10,661 DEBUG : BROWSER_OUTPUT: Values: 161.0 169.0 170.0 183.0 162.0 162.0 174.0 173.0 173.0 170.0 21:34:10 INFO - 2015-11-15 21:34:10,662 DEBUG : BROWSER_OUTPUT: 21:34:10 INFO - 2015-11-15 21:34:10,662 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:197.70 Median:201.00 stddev:5.14 (2.6%) stddev-sans-first:4.64 21:34:10 INFO - 2015-11-15 21:34:10,662 DEBUG : BROWSER_OUTPUT: Values: 190.0 202.0 201.0 202.0 201.0 198.0 192.0 198.0 203.0 190.0 21:34:10 INFO - 2015-11-15 21:34:10,662 DEBUG : BROWSER_OUTPUT: 21:34:10 INFO - 2015-11-15 21:34:10,662 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:89.70 Median:91.00 stddev:2.83 (3.1%) stddev-sans-first:1.67 21:34:10 INFO - 2015-11-15 21:34:10,663 DEBUG : BROWSER_OUTPUT: Values: 83.0 87.0 89.0 92.0 90.0 92.0 91.0 90.0 91.0 92.0 21:34:10 INFO - 2015-11-15 21:34:10,663 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:34:10 INFO - 2015-11-15 21:34:10,663 DEBUG : BROWSER_OUTPUT: 21:34:11 INFO - 2015-11-15 21:34:11,419 INFO : Browser exited with error code: 0 21:34:11 INFO - 2015-11-15 21:34:11,478 INFO : Completed test kraken (00:01:04) 21:34:11 INFO - 2015-11-15 21:34:11,478 INFO : Starting test v8_7 21:34:11 INFO - 2015-11-15 21:34:11,478 DEBUG : operating with platform_type : mac_ 21:34:11 INFO - 2015-11-15 21:34:11,479 INFO : Initialising browser for v8_7 test... 21:34:11 INFO - 2015-11-15 21:34:11,494 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/tmptfR0wV/profile http://localhost:50138/getInfo.html 21:34:14 INFO - 2015-11-15 21:34:14,962 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 21:34:14 INFO - 2015-11-15 21:34:14,962 DEBUG : BROWSER_OUTPUT: colorDepth:24 21:34:14 INFO - 2015-11-15 21:34:14,963 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 21:34:14 INFO - 2015-11-15 21:34:14,963 DEBUG : BROWSER_OUTPUT: __metrics 21:34:15 INFO - 2015-11-15 21:34:15,679 INFO : Browser initialized. 21:34:15 INFO - 2015-11-15 21:34:15,679 INFO : Running cycle 1/1 for v8_7 test... 21:34:15 INFO - 2015-11-15 21:34:15,679 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/T/tmptfR0wV/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 21:34:27 INFO - 2015-11-15 21:34:27,973 DEBUG : BROWSER_OUTPUT: RSS: Main: 240988160 21:34:27 INFO - 2015-11-15 21:34:27,973 DEBUG : BROWSER_OUTPUT: 21:34:50 INFO - 2015-11-15 21:34:50,626 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:50138/tests/v8_7/run.html (next: http://localhost:50138/tests/v8_7/run.html) 21:34:50 INFO - 2015-11-15 21:34:50,883 DEBUG : BROWSER_OUTPUT: RSS: Main: 261189632 21:34:50 INFO - 2015-11-15 21:34:50,883 DEBUG : BROWSER_OUTPUT: 21:34:50 INFO - 2015-11-15 21:34:50,883 DEBUG : BROWSER_OUTPUT: __start_tp_report 21:34:50 INFO - 2015-11-15 21:34:50,883 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 21:34:50 INFO - 2015-11-15 21:34:50,883 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 21:34:50 INFO - 2015-11-15 21:34:50,884 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 21:34:50 INFO - 2015-11-15 21:34:50,884 DEBUG : BROWSER_OUTPUT: |0;Richards;896.1504028648164 21:34:50 INFO - 2015-11-15 21:34:50,884 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;242.14596423392945 21:34:50 INFO - 2015-11-15 21:34:50,884 DEBUG : BROWSER_OUTPUT: |2;Encrypt;387.8975950349108 21:34:50 INFO - 2015-11-15 21:34:50,884 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7113.475177304965 21:34:50 INFO - 2015-11-15 21:34:50,884 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1376.8913342503438 21:34:50 INFO - 2015-11-15 21:34:50,884 DEBUG : BROWSER_OUTPUT: |5;Earley;996.0199004975125 21:34:50 INFO - 2015-11-15 21:34:50,885 DEBUG : BROWSER_OUTPUT: |6;Boyer;16683.333333333332 21:34:50 INFO - 2015-11-15 21:34:50,885 DEBUG : BROWSER_OUTPUT: |7;RegExp;34913.793103448275 21:34:50 INFO - 2015-11-15 21:34:50,885 DEBUG : BROWSER_OUTPUT: |8;Splay;903.863432165319 21:34:50 INFO - 2015-11-15 21:34:50,885 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6937.931034482759 21:34:50 INFO - 2015-11-15 21:34:50,885 DEBUG : BROWSER_OUTPUT: __end_tp_report 21:34:50 INFO - 2015-11-15 21:34:50,885 DEBUG : BROWSER_OUTPUT: __startTimestamp1447652090877__endTimestamp 21:34:50 INFO - 2015-11-15 21:34:50,885 DEBUG : BROWSER_OUTPUT: 21:34:50 INFO - 2015-11-15 21:34:50,885 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 21:34:50 INFO - 2015-11-15 21:34:50,886 DEBUG : BROWSER_OUTPUT: Number of tests: 10 21:34:50 INFO - 2015-11-15 21:34:50,886 DEBUG : BROWSER_OUTPUT: 21:34:50 INFO - 2015-11-15 21:34:50,886 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:896.15 Median:896.15 stddev:0.00 (0.0%) 21:34:50 INFO - 2015-11-15 21:34:50,886 DEBUG : BROWSER_OUTPUT: Values: 896.2 21:34:50 INFO - 2015-11-15 21:34:50,886 DEBUG : BROWSER_OUTPUT: 21:34:50 INFO - 2015-11-15 21:34:50,886 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:242.15 Median:242.15 stddev:0.00 (0.0%) 21:34:50 INFO - 2015-11-15 21:34:50,886 DEBUG : BROWSER_OUTPUT: Values: 242.1 21:34:50 INFO - 2015-11-15 21:34:50,886 DEBUG : BROWSER_OUTPUT: 21:34:50 INFO - 2015-11-15 21:34:50,886 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:387.90 Median:387.90 stddev:0.00 (0.0%) 21:34:50 INFO - 2015-11-15 21:34:50,887 DEBUG : BROWSER_OUTPUT: Values: 387.9 21:34:50 INFO - 2015-11-15 21:34:50,887 DEBUG : BROWSER_OUTPUT: 21:34:50 INFO - 2015-11-15 21:34:50,887 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7113.48 Median:7113.48 stddev:0.00 (0.0%) 21:34:50 INFO - 2015-11-15 21:34:50,887 DEBUG : BROWSER_OUTPUT: Values: 7113.5 21:34:50 INFO - 2015-11-15 21:34:50,887 DEBUG : BROWSER_OUTPUT: 21:34:50 INFO - 2015-11-15 21:34:50,887 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1376.89 Median:1376.89 stddev:0.00 (0.0%) 21:34:50 INFO - 2015-11-15 21:34:50,887 DEBUG : BROWSER_OUTPUT: Values: 1376.9 21:34:50 INFO - 2015-11-15 21:34:50,887 DEBUG : BROWSER_OUTPUT: 21:34:50 INFO - 2015-11-15 21:34:50,887 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:996.02 Median:996.02 stddev:0.00 (0.0%) 21:34:50 INFO - 2015-11-15 21:34:50,887 DEBUG : BROWSER_OUTPUT: Values: 996.0 21:34:50 INFO - 2015-11-15 21:34:50,887 DEBUG : BROWSER_OUTPUT: 21:34:50 INFO - 2015-11-15 21:34:50,888 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:16683.33 Median:16683.33 stddev:0.00 (0.0%) 21:34:50 INFO - 2015-11-15 21:34:50,888 DEBUG : BROWSER_OUTPUT: Values: 16683.3 21:34:50 INFO - 2015-11-15 21:34:50,888 DEBUG : BROWSER_OUTPUT: 21:34:50 INFO - 2015-11-15 21:34:50,888 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:34913.79 Median:34913.79 stddev:0.00 (0.0%) 21:34:50 INFO - 2015-11-15 21:34:50,888 DEBUG : BROWSER_OUTPUT: Values: 34913.8 21:34:50 INFO - 2015-11-15 21:34:50,888 DEBUG : BROWSER_OUTPUT: 21:34:50 INFO - 2015-11-15 21:34:50,889 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:903.86 Median:903.86 stddev:0.00 (0.0%) 21:34:50 INFO - 2015-11-15 21:34:50,889 DEBUG : BROWSER_OUTPUT: Values: 903.9 21:34:50 INFO - 2015-11-15 21:34:50,889 DEBUG : BROWSER_OUTPUT: 21:34:50 INFO - 2015-11-15 21:34:50,889 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6937.93 Median:6937.93 stddev:0.00 (0.0%) 21:34:50 INFO - 2015-11-15 21:34:50,889 DEBUG : BROWSER_OUTPUT: Values: 6937.9 21:34:50 INFO - 2015-11-15 21:34:50,889 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 21:34:50 INFO - 2015-11-15 21:34:50,889 DEBUG : BROWSER_OUTPUT: 21:34:51 INFO - 2015-11-15 21:34:51,631 INFO : Browser exited with error code: 0 21:34:51 INFO - 2015-11-15 21:34:51,655 INFO : Completed test v8_7 (00:00:40) 21:34:51 INFO - 2015-11-15 21:34:51,796 INFO : Completed test suite (00:20:16) 21:34:51 INFO - 2015-11-15 21:34:51,796 DEBUG : Working with test: dromaeo_css 21:34:51 INFO - 2015-11-15 21:34:51,796 DEBUG : Generating results file: dromaeo_css 21:34:51 INFO - 2015-11-15 21:34:51,797 DEBUG : Working with test: kraken 21:34:51 INFO - 2015-11-15 21:34:51,797 DEBUG : Generating results file: kraken 21:34:51 INFO - 2015-11-15 21:34:51,797 INFO : javascript benchmark 21:34:51 INFO - 2015-11-15 21:34:51,798 DEBUG : Working with test: v8_7 21:34:51 INFO - 2015-11-15 21:34:51,798 DEBUG : Generating results file: v8_7 21:34:51 INFO - 2015-11-15 21:34:51,798 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:34:51 INFO - 2015-11-15 21:34:51,847 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,57]] 21:34:51 INFO - 2015-11-15 21:34:51,847 DEBUG : process_Request line: dromaeo_css 5648.30 graph.html#tests=[[72,64,57]] 21:34:51 INFO - 2015-11-15 21:34:51,847 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:34:51 INFO - 2015-11-15 21:34:51,874 DEBUG : process_Request line: kraken 1952.60 graph.html#tests=[[232,64,57]] 21:34:51 INFO - 2015-11-15 21:34:51,874 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 21:34:52 INFO - 2015-11-15 21:34:52,007 DEBUG : process_Request line: v8_7 13577.83 graph.html#tests=[[230,64,57]] 21:34:52 INFO - 2015-11-15 21:34:52,008 INFO : javascript benchmark 21:34:52 INFO - 2015-11-15 21:34:52,010 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [275.1539017521123, 275.4477273067499, 279.3895338684973, 280.3901514206601, 284.04136040862096, 11658.533658653643, 14204.715905681893, 14505.854941450596, 14517.854821451769, 14944.925275373607, 13986.230757308344, 14259.50091746789, 15755.0, 16388.93471924324, 16445.91777041116, 4797.424309082915, 4957.925631115536, 5035.471275516073, 5055.39335279767, 5132.8460146195675, 5034.949650503503, 5115.0, 5123.077845987721, 5142.07442660321, 5144.254083157958, 4760.095581839457, 5105.438401775802, 5263.605229607795, 5564.998300305963, 5582.609217354787, 5535.335759708821, 5573.916391254114, 5588.86027849303, 5605.663660180402, 5650.491455769001, 5211.557017653504, 5347.224652425415, 5437.891242175135, 5442.0, 5484.890302193934, 14655.560333190022, 15023.549293521211, 15061.924690376587, 17859.910700446544, 18269.360572379905, 1642.6550424410889, 1689.628281778019, 1715.5711072231943, 1716.6395057038037, 1792.811754765744, 11579.942100289445, 11724.88275117255, 11974.161808673396, 12232.81650775239, 12486.188397754117, 1460.4085345435117, 1480.7630779075405, 1486.754685476895, 1491.5599898030107, 1492.798472206249, 42096.1580768386, 44060.898477537994, 48326.516734832556, 48875.0, 55693.72153139249, 13560.59318220455, 14176.645583860485, 14460.276986150651, 14465.421383144767, 14486.782698259534, 20339.0, 20402.795972040385, 20437.795622043886, 20699.172033118506, 20825.583488330147, 7298.598577078205, 7328.230535793771, 7421.666025028887, 7625.847483050308, 7631.1605723370385, 5999.880002400015, 6108.664023478751, 6131.478824299985, 6380.776672816429, 6515.381038801306, 6722.260551339349, 6869.931300686929, 6899.896501552481, 6941.652917354112, 6947.131608548932, 2783.6381270434713, 2793.539066054119, 2809.7752179825566, 2812.5359315713085, 2819.802613817054, 333.2934179539392, 343.78513429106806, 348.86743037645533, 356.7181926278263, 357.8640116755668, 8851.33614978879, 9344.95327523358, 9346.0653934606, 9365.11031452011, 9653.517324133765, 380.7258773682944, 387.2197521993186, 388.3630845413524, 397.2908358579921, 409.2224772931454, 4857.222844344888, 4906.1414252505665, 5181.766820493087, 5203.16749320107, 5222.0, 425826.0, 434921.0, 435275.0, 442920.0, 454663.0, 55557.16664250039, 56180.438195618335, 56929.430705693245, 57688.13467797986, 58215.0, 418.73201151263214, 419.39816363518446, 420.8800491859805, 422.4423760635992, 425.3237352609366, 8526.232639062515, 8541.14588541141, 8612.78468038304, 8672.349573782118, 8710.520921349387, 26777.464450710486, 27191.86404067967, 27329.863350683914, 27651.58522622122, 28040.29899252535, 37438.251234975694, 37758.62241377551, 37949.620503794606, 38110.0, 38635.2272954545, 6344.714487847966, 6384.489240860627, 6488.351164883474, 6550.279469258473, 6564.8358791030605, 9460.479673618018, 9622.290099083606, 9631.903680963382, 9761.219102471643, 9929.304948653813, 6919.481038922, 7344.375728062961, 8103.959480202797, 8284.46151000183, 8489.660413583388, 6791.796246112624, 7748.7675369739, 7831.8825217622925, 8090.555019473985, 8264.504129752235, 8137.145599711945, 8142.837143256983, 8203.71287004952, 8417.032041315328, 8465.95767021161, 6160.353162918008, 6254.124422580751, 6264.185655864709, 6350.7777227796805, 6374.171357723466, 8002.1997800219515, 8024.358051355761, 8031.156728543652, 8043.316318112792, 8077.515349079074], "dojo.html": [2545.223706769435, 2610.0734239345034, 2676.47808677308, 2677.1968409477154, 2688.87900044498, 4277.101808620189, 4355.303151495761, 4475.7985890635, 4482.955170448295, 4536.092781443712, 4218.704690671654, 4356.0, 4361.345798130282, 4389.078293558357, 4498.325251212312, 4092.815823287944, 4100.671946244308, 4133.379993001044, 4135.875923722293, 4167.562405947378, 220.23885334717994, 4110.856120035799, 4203.222403855281, 4224.746515209097, 4241.045764702948, 4022.517297924268, 4046.979765101185, 4081.795910204493, 4106.630403263691, 4138.296489596776, 4115.1975364803575, 4132.586741325874, 4136.234796562646, 4195.888089656243, 4233.089885674594, 3935.252302062599, 4044.0496483326397, 4095.672346212296, 4133.503979522447, 4150.335946248586, 4149.502059752849, 4260.382244574519, 4311.719738217006, 4412.029353542215, 4466.419365482499, 4651.116287905287, 4679.368285281477, 4739.052189562101, 4752.07334569759, 4828.348172996635, 4702.153612349775, 4746.7389293589185, 4750.0, 4791.928121078186, 4794.5205479452125, 4461.888452788641, 4470.061287129706, 4473.4408198975125, 4500.684952053391, 4525.637948964075, 4891.926621100686, 4896.779644915988, 4926.5073492650445, 4948.975255123773, 4979.253112033151, 4411.801468933906, 4467.084247729208, 4592.770361481913, 4608.078384323148, 4689.812407503729, 4703.717776933327, 4761.428628564525, 4784.354112194878, 4806.255030470283, 4844.563989240985, 4640.512746161672, 4679.22792739201, 4708.952910470852, 4716.6698331116495, 4753.025629745894, 4494.415725955605, 4575.771211439414, 4607.6313894889, 4685.297205419214, 4720.409948756405, 3619.2218672985437, 3620.8008559528953, 3646.0, 3674.2284120334493, 3680.0063982724514, 3265.232670322472, 3320.037189215149, 3335.766496345281, 3369.124027752802, 3376.4260075787174, 4359.062801497693, 4398.142362239397, 4414.668899832525, 4427.180971520279, 4524.185646583581, 4818.180909245437, 4822.445418776815, 4835.153848076572, 4843.660943733976, 4883.902321953612, 4291.270484017725, 4426.358178064227, 4453.821847126143, 4510.571495707903, 4558.2251017327135, 4064.248114098901, 4084.9387259191135, 4101.138760860253, 4157.272477316518, 4160.479940007499, 4897.730624815598, 4918.311436398907, 4931.97534012342, 4933.555979961749, 5027.723475208825, 4657.231556793091, 4714.575688187942, 4773.498782627774, 4841.515848415131, 4881.0, 4954.455009948831, 4963.280324352876, 4963.528464795839, 5024.84925452237, 5075.568576670877, 4710.81156753726, 4718.41019872516, 4738.360321356573, 4742.549457801503, 4767.213409787346, 4643.907121857612, 4676.859694209179, 4746.4541577719, 4788.784504697227, 4862.927056094232, 4609.516000819865, 4644.0711857629285, 4651.116287905287, 4691.460482044608, 4696.8121275148615, 4642.791074401593, 4650.813967441264, 4651.372064771348, 4653.86038418848, 4734.952650473451, 4443.4445694288215, 4492.236319825703, 4503.414556107685, 4514.683972122051, 4614.215583350771, 4517.6837621366185, 4566.840160594364, 4579.816807327669, 4582.060677561025, 4694.953050469589, 4405.449318835145, 4590.517995610413, 4614.307853821953, 4647.628189744744, 4666.92999605013], "mootools.html": [1445.5591044731357, 1453.4404254362069, 1463.7657974724045, 1494.8505149485052, 1527.9847201527984, 5279.340082489689, 5465.890682186359, 5476.17857321402, 5866.5600079994065, 6156.938430615693, 6391.360863913606, 6438.066480360345, 6595.7691480798185, 6606.3723946225155, 6629.436497897673, 1866.4773863318258, 1899.3637131560943, 1902.5719213177063, 1906.6377388296248, 1906.961860762784, 1909.6180763847217, 1953.3163392812473, 1956.178405069874, 1959.8828667659368, 1994.601079784049, 1892.5741708115634, 1924.7401600783855, 1924.8748831325988, 1955.5404479947201, 1957.862949593529, 1803.6212395396983, 1857.8606604504716, 1861.6835138026568, 1889.7732272127296, 1893.0440127735544, 1861.9069046547754, 1873.166440933785, 1875.4373687893578, 1882.6517094337592, 1945.4649971257875, 6574.76988305407, 6661.700223489906, 6735.427488663469, 6761.0, 6796.558223715443, 3985.322495175827, 4075.4701888754566, 4078.8776336709648, 4104.240715467648, 4146.647534959532, 2184.191849015858, 2236.105557776886, 2360.5986982212894, 2463.9753602463925, 2499.3376755159898, 736.223284434921, 744.8659241336558, 748.4685873030155, 752.405599576334, 773.5397438524069, 8500.809886615878, 8739.694110706096, 8783.604737786814, 8899.288056955427, 8901.910980890172, 3776.811159442017, 3788.5264341957254, 3827.445020472016, 3844.8462061517225, 3918.6081391861157, 7568.205338439495, 7581.962090189514, 7605.6577454014705, 7646.923530764732, 7693.576853273012, 4138.79306034697, 4138.896527586834, 4171.457710497677, 4172.395002724588, 4233.534311225762, 3755.549334079928, 3757.5490941087246, 3764.5294338207723, 3768.3593789055926, 3823.25446537928, 3146.087634585944, 3160.146760374686, 3192.2338638726537, 3199.7120259176786, 3224.6936541028563, 995.5918073589794, 1001.519270750044, 1002.2483137646765, 1002.283367392318, 1026.958921643141, 1047.7537778622018, 1076.983845242322, 1092.0608276881876, 1107.374333501569, 1109.4120116338354, 6179.752809887555, 6216.782412615627, 6225.533085018642, 6333.018382150774, 6350.936490635035, 398.7687141457947, 408.7772164170534, 409.28171059790475, 409.7500524679943, 411.2699957575328, 4755.857324280277, 4833.347498087714, 4845.49122342149, 4874.561289483963, 4881.0, 7426.480146389701, 7787.10448298453, 7797.337226335825, 7866.72466463671, 7910.9604451977375, 7648.34989025939, 7652.120006199247, 7658.425618078666, 7683.1548529661695, 7756.612169391507, 5549.722513874371, 5806.361300256968, 6131.540134489931, 6164.198654175018, 6196.287426945869, 6072.423119803611, 6220.129181914626, 6223.190985171898, 6283.2460104787715, 6335.461485773761, 6837.3162683731225, 6908.965455172893, 7085.0, 7095.219525852049, 7105.928940710527, 7051.471139664648, 7196.96401517989, 7289.890651640124, 7316.1952185258515, 7446.032015837906, 5810.837832433445, 5879.823605291848, 5934.43622855828, 5959.22530071088, 5968.432998865101, 6358.682065896779, 6382.904256436064, 6392.169018027813, 6422.197225346832, 6446.323136070832, 5871.941280587311, 5934.495567876779, 5968.46283834457, 6064.969675151596, 6105.572609917263, 5863.472287494146, 5903.203067585821, 5905.970470147794, 5944.6730429826775, 5974.940250597612, 5966.343702192842, 6006.849828754316, 6013.849653758691, 6021.307549631849, 6033.547483938634, 5351.464853514617, 5378.19327100938, 5422.810201642924, 5431.103867861759, 5505.752241149078, 4812.278158276286, 4943.65394422387, 5396.3524377075, 5473.698946557818, 5547.583931205257], "ext.html": [439.86144364525194, 454.51594052334264, 458.9977050114749, 478.7558345243926, 497.28887690602426, 32704.0, 33427.66572334276, 33691.83154084229, 34357.141071473256, 34426.31147377051, 35164.82417587915, 35565.46651800225, 35839.0, 36175.0, 36217.2756544869, 7588.0, 7724.806879827993, 7825.960870195641, 7857.292843644071, 7883.2116788321, 7497.925020749804, 7541.924580754205, 7568.886466703004, 7605.0, 7677.2322767723335, 7586.4689471737, 7676.884846727304, 7684.269994350556, 7700.229977002311, 7734.535927844319, 7438.739644112457, 7524.736634217831, 7584.810379740551, 7628.0464941882265, 7638.694452221932, 7474.813129671747, 7612.809679757995, 7687.077550693953, 7696.11494678108, 7755.495892766952, 33389.83305083483, 33420.665793342, 33440.83279583611, 34018.82990585056, 34165.65834341675, 2041.13251867957, 2239.3841693534246, 2280.395695140789, 2528.443742376674, 3092.567040614316, 21862.30366753795, 22535.323940281818, 23039.654405183937, 23232.186873459515, 23716.762832371627, 1905.247427266222, 1907.0464767616193, 1947.2113793913345, 1960.9509762255916, 1962.4014675523958, 203801.0, 205261.0, 205389.0, 207569.0, 208708.0, 36892.262154756754, 49202.26196607054, 49588.25617615667, 50061.74969125131, 50503.74748126309, 37188.442173367424, 37241.0, 37251.25497490035, 37257.44113838294, 37811.24377512434, 11197.272177308449, 11340.20618556693, 11346.0355869752, 11387.658370248906, 11450.541978320774, 8731.60707768152, 8779.561021948877, 8795.868061979076, 8820.911790882137, 8916.598753055998, 11807.645770626896, 11880.287182769061, 11896.643100706993, 11981.820272695917, 12053.457594408274, 5085.491450854959, 5186.714730689849, 5197.922031169535, 5204.661696989683, 5211.530962213343, 825.5253229393123, 830.3979614779237, 855.2601999270586, 878.9428687135315, 879.6437442835662, 23907.16324928619, 24067.398315042265, 24281.271561853173, 24340.878295608763, 24378.146764863144, 843.4138273899581, 847.9448835825651, 871.6905498547924, 888.7511496780912, 894.8031433084711, 12349.382530873421, 12398.81401778974, 12424.192427492184, 12452.439640216213, 12583.11918165738, 329835.0, 331797.0, 333689.0, 334893.0, 335034.0, 48250.758746206746, 48841.511584883694, 48896.26655600169, 49213.75393123083, 49255.50744492581, 1107.534835369147, 1107.5403707461473, 1119.5353928119903, 1123.6348186839145, 1140.4639819284923, 23766.762332377148, 26942.0, 27247.0, 27266.0, 27454.450910981268, 43040.784796077074, 43848.34227486527, 44553.0, 44564.77717611521, 44646.0, 228823.0, 230921.0, 232651.0, 233706.0, 234986.0, 35256.64743352534, 35314.1171470705, 37108.814455927546, 38641.42037869491, 38803.223935521695, 35594.0, 36035.27929441449, 36264.456033159, 36673.083172919825, 37413.438798417505, 30138.84930575333, 30914.53628195624, 31022.0, 31054.53418198774, 31190.688093118777, 30114.69885301119, 30361.848190758905, 30402.087937361914, 30431.695683042886, 32400.513992289663, 30610.693893060783, 30629.540556891217, 31132.533012004384, 31237.8438107808, 31478.37043259076, 25414.237572872844, 26959.191224263304, 27082.187534374, 27239.72760272372, 27458.17625471159, 20285.59428811445, 20443.284485042954, 20458.38624841257, 20597.0, 20725.170993160104], "prototype.html": [259.4512605838651, 261.49792398594695, 266.9452762183752, 268.55554058033954, 271.17021912946376, 5127.871803204922, 5200.713960732158, 5243.973780131094, 5305.575553955679, 5358.946410535894, 5034.521720436553, 5179.0, 5186.247994040862, 5221.295125158112, 5295.894082118355, 3967.761934283952, 3995.12107336387, 4011.2980228460046, 4014.8193331300017, 4050.696197785178, 3988.24223397555, 4037.454943582623, 4045.7774822384904, 4047.494063242095, 4060.2894493463527, 3865.323568375537, 3940.822662980173, 3956.188981258835, 4016.3975403689387, 4021.4772079629606, 3919.9216015679526, 3971.721979461439, 3974.4435778990965, 3979.621935916083, 3989.4215338775716, 3414.709749671281, 3428.674275943781, 3432.7768695034742, 3433.8626454941773, 3447.258839349552, 4837.443693975168, 5007.92488112675, 5023.673461225008, 5135.845924622267, 5143.819966301199, 4466.843660471868, 4469.08383781324, 4474.619657329131, 4504.1892459357305, 4553.704009239389, 5447.5914306426785, 5455.454454554552, 5464.562834973192, 5536.4186760390385, 5545.861353466155, 3697.2605478904325, 3698.4082546792383, 3707.3141468828353, 3720.6093360197333, 3740.121071548184, 5610.775568977236, 5626.662400255997, 5674.233978412903, 5698.686572238566, 5802.738876750556, 3769.453429252743, 3778.7354885157774, 3780.092777733379, 3805.82873770681, 3837.6929845612285, 3859.363205071188, 3864.8019114074727, 3868.6518213360932, 3876.341022026262, 3895.941560876589, 4443.37792709021, 4447.199504089295, 4447.73313601185, 4464.241079016575, 4517.028838799608, 5213.7914483421, 5251.842444726664, 5421.5933804964, 5431.891362172734, 5488.9725551371985, 1322.3520474967388, 1355.6339788257114, 1360.4762166565943, 1366.3441548056987, 1368.1722557852554, 881.7883707910055, 887.1040249348076, 896.8340856941487, 906.7687739626354, 907.0702529906766, 5196.792128314901, 5204.297419848348, 5223.555997740159, 5253.763580638881, 5264.394594621591, 5645.717714114277, 5651.124075768263, 5676.290463692038, 5734.4838964492565, 5735.0250457422335, 5225.268462415265, 5228.398734145546, 5235.973820130951, 5309.7079660618265, 5313.521783039545, 2960.304328482805, 3026.3493348930087, 3060.234941264684, 3065.157081802522, 3114.1280441476424, 5813.680247586339, 5870.559708021916, 5882.205902203234, 5916.437938395846, 5933.258342707161, 5819.82540523785, 5825.679587622637, 5841.707914604252, 5851.444112809277, 5868.178455016301, 5677.205191273308, 5804.390538993429, 5824.650520968671, 5905.822825315161, 5921.0, 5608.46719561641, 5634.126710359901, 5667.603267771216, 5691.4877661010705, 5694.629849059798, 5459.962607104638, 5502.972485137709, 5555.2222688822785, 5562.193481945176, 5566.276384070045, 5760.222369979999, 5830.883382332415, 5850.356460789225, 5904.988455887443, 5908.202392676933, 3694.6674799268194, 3791.279656865187, 3808.847646094125, 3868.032991752062, 3873.0, 5499.477549632778, 5581.358143813513, 5584.46947539983, 5691.288588926384, 5703.058995265735, 5362.758675859518, 5492.066348720807, 5530.087535556588, 5614.382417934105, 5617.382087970402, 5526.806561770319, 5548.278723765885, 5588.3573389060775, 5604.383517812956, 5610.102383618601, 5235.3717553893775, 5390.676559406448, 5439.0, 5475.206095116266, 5491.121420572689, 5518.392976772632, 5540.307461567304, 5584.078627026495, 5610.438956104357, 5621.690807005654, 5412.890357476786, 5418.268533748052, 5482.506574408322, 5484.341878974548, 5504.6421982571], "yui.html": [589.9439553242444, 597.2176448852005, 622.6917675750504, 625.4277336237342, 627.8838414893243, 10108.646197383094, 11026.724331891706, 11078.446077696102, 11298.717532061703, 11304.152188585847, 10493.737656558571, 10493.895061049407, 10564.471776411187, 10687.0, 10712.357258564492, 576.7837061102086, 586.7330364684059, 713.9357457828794, 721.700494294867, 729.7810656802965, 722.241646271413, 727.6180005497104, 738.6122285799944, 748.7529115391908, 752.9322360987537, 748.8090536913106, 767.5624893810502, 768.561919705768, 768.6656304507529, 780.4809801482036, 751.3087959077661, 752.9134149572787, 762.1007211490439, 763.522798251093, 773.5938632218074, 549.5493695169962, 550.1747378931602, 551.0246863052415, 559.5132234955614, 559.6362364463091, 11078.889211107866, 11207.66377008691, 11234.382108984002, 11237.213395062348, 11437.542498300058, 8724.127587241288, 9189.44863308197, 9361.578728957213, 9412.529373531295, 10294.279400441972, 7369.668364923537, 7517.4737768356235, 7595.126560445564, 7834.0, 7982.880256796153, 2424.2969538833718, 2496.962545561818, 2549.0823303610687, 2554.7189809120982, 2842.0905310300714, 35130.121746956276, 35934.46098308502, 36456.088597785005, 36514.63485365139, 36714.0, 5505.119180931032, 5518.0, 5606.887862242732, 5697.772089116472, 5793.94206057934, 9597.184239339595, 9685.854712179324, 9687.612495500241, 9801.705948821547, 9894.15899648538, 4959.752012399365, 4979.850604481871, 5025.020121076428, 5035.093683137071, 5056.6207534434325, 2902.912912612625, 2908.6073380093417, 2961.2744877505147, 3022.652394974562, 3103.1466346754373, 2115.756687980871, 2159.29822807585, 2165.750938642076, 2169.945751356229, 2170.392290158758, 326.24311597094515, 331.8821818254533, 332.6706560505131, 333.1853617904201, 334.0196523204403, 369.52700543304616, 463.367503357914, 479.31936649957146, 496.9826056088092, 503.4587818095489, 6336.398042186077, 6583.518708290692, 6598.802035938834, 6748.662566871637, 6781.728730850711, 349.3101125277557, 417.8098964970931, 486.8977514721948, 496.85839535732146, 502.68330951501054, 3111.8132912025353, 3136.090533745234, 3161.3993341265086, 3193.728533074668, 3218.8873389431255, 47860.5213947863, 48227.276590851165, 48262.51737482651, 48562.27156592654, 48766.512334876905, 40098.19803603912, 40528.797356013034, 40777.38833917493, 40901.795491022356, 41254.38118428226, 36152.0, 36416.635833641856, 36726.449103263476, 37398.62601374006, 38195.0, 6297.0, 6347.206599175103, 6464.644444555406, 6483.286838447862, 6505.902411463737, 28268.85865570659, 28859.278518037216, 28950.42099158047, 29019.564706528996, 29140.562891557067, 34395.65604344025, 34482.41381896418, 36965.0, 37326.626733732315, 37574.62425375821, 5866.2373891393845, 5973.014452615444, 5998.640081595118, 6107.328193898757, 6299.559030867796, 8152.755417337489, 8341.708040218806, 8419.452735572168, 8469.830603388022, 8556.401051926305, 7923.762287131395, 7990.453223280351, 8047.879281810895, 8097.068837083811, 8108.554029528433, 7862.007257543326, 7897.170797066455, 7947.642356093874, 8009.639566219417, 8014.358851292, 7787.844243115219, 7809.804754881174, 8134.023917129983, 8164.346852251924, 8382.622781974947, 6859.5541289818, 6928.309576370124, 7096.7516136934955, 7385.96307018483, 7477.513961592479, 6695.531312808252, 7054.576725396492, 7262.128544574685, 7272.854542909218, 7277.235890231449]}, "summary": {"lowerIsBetter": false, "suite": 5648.302858735501, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6884.183846671629, "unit": "ms", "value": 6884.183846671629}, "dojo.html": {"lowerIsBetter": false, "filtered": 4364.096277440822, "unit": "ms", "value": 4364.096277440822}, "mootools.html": {"lowerIsBetter": false, "filtered": 3703.7558292400117, "unit": "ms", "value": 3703.7558292400117}, "ext.html": {"lowerIsBetter": false, "filtered": 15121.13225325984, "unit": "ms", "value": 15121.13225325984}, "prototype.html": {"lowerIsBetter": false, "filtered": 4117.297208974576, "unit": "ms", "value": 4117.297208974576}, "yui.html": {"lowerIsBetter": false, "filtered": 4686.804282022402, "unit": "ms", "value": 4686.804282022402}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0062.e"}, "testrun": {"date": 1447650875, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115191934", "branch": "Fx-Team", "revision": "04fb61e343addd47b88ac694041c0bce5a98cfc0"}}, {"talos_counters": {}, "results": {"audio-dft": [215.0, 207.0, 209.0, 213.0, 212.0, 214.0, 211.0, 211.0, 214.0, 210.0], "ai-astar": [133.0, 129.0, 140.0, 140.0, 140.0, 155.0, 140.0, 141.0, 140.0, 138.0], "imaging-gaussian-blur": [156.0, 149.0, 149.0, 156.0, 157.0, 157.0, 155.0, 149.0, 157.0, 149.0], "audio-beat-detection": [206.0, 171.0, 193.0, 207.0, 164.0, 189.0, 197.0, 175.0, 207.0, 169.0], "json-stringify-tinderbox": [85.0, 88.0, 90.0, 93.0, 92.0, 94.0, 94.0, 94.0, 94.0, 95.0], "stanford-crypto-pbkdf2": [190.0, 202.0, 201.0, 202.0, 201.0, 198.0, 192.0, 198.0, 203.0, 190.0], "json-parse-financial": [73.0, 77.0, 78.0, 81.0, 83.0, 82.0, 81.0, 90.0, 82.0, 83.0], "stanford-crypto-sha256-iterative": [83.0, 87.0, 89.0, 92.0, 90.0, 92.0, 91.0, 90.0, 91.0, 92.0], "audio-fft": [85.0, 91.0, 105.0, 156.0, 85.0, 89.0, 89.0, 89.0, 128.0, 84.0], "imaging-darkroom": [164.0, 164.0, 165.0, 165.0, 164.0, 164.0, 164.0, 165.0, 167.0, 163.0], "stanford-crypto-ccm": [161.0, 169.0, 170.0, 183.0, 162.0, 162.0, 174.0, 173.0, 173.0, 170.0], "audio-oscillator": [107.0, 109.0, 161.0, 112.0, 114.0, 114.0, 156.0, 114.0, 114.0, 161.0], "stanford-crypto-aes": [107.0, 111.0, 113.0, 110.0, 112.0, 111.0, 111.0, 111.0, 112.0, 112.0], "imaging-desaturate": [123.0, 136.0, 124.0, 134.0, 126.0, 130.0, 126.0, 124.0, 124.0, 137.0]}, "summary": {"lowerIsBetter": true, "suite": 1952.6000000000004, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 100.1, "unit": "ms", "value": 100.1}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 197.7, "unit": "ms", "value": 197.7}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 187.8, "unit": "ms", "value": 187.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 169.7, "unit": "ms", "value": 169.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 164.5, "unit": "ms", "value": 164.5}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 81.0, "unit": "ms", "value": 81.0}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 126.2, "unit": "ms", "value": 126.2}, "ai-astar": {"lowerIsBetter": true, "filtered": 139.6, "unit": "ms", "value": 139.6}, "audio-dft": {"lowerIsBetter": true, "filtered": 211.6, "unit": "ms", "value": 211.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 89.7, "unit": "ms", "value": 89.7}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 91.9, "unit": "ms", "value": 91.9}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 153.4, "unit": "ms", "value": 153.4}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 111.0, "unit": "ms", "value": 111.0}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 128.4, "unit": "ms", "value": 128.4}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0062.e"}, "testrun": {"date": 1447650875, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115191934", "branch": "Fx-Team", "revision": "04fb61e343addd47b88ac694041c0bce5a98cfc0"}}, {"talos_counters": {}, "results": {"DeltaBlue": [242.14596423392945], "Encrypt": [387.8975950349108], "NavierStokes": [6937.931034482759], "Decrypt": [7113.475177304965], "Splay": [903.863432165319], "Richards": [896.1504028648164], "RegExp": [34913.793103448275], "Earley": [996.0199004975125], "Boyer": [16683.333333333332], "RayTrace": [1376.8913342503438]}, "summary": {"lowerIsBetter": false, "suite": 13577.82988042199, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 273.0501836327346, "unit": "score", "value": 273.0501836327346}, "Encrypt": {"lowerIsBetter": false, "filtered": 686.2146180000002, "unit": "score", "value": 686.2146180000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 213.89662027832998, "unit": "score", "value": 213.89662027832998}, "Decrypt": {"lowerIsBetter": false, "filtered": 37.419263210368875, "unit": "score", "value": 37.419263210368875}, "Splay": {"lowerIsBetter": false, "filtered": 90.15853180914513, "unit": "score", "value": 90.15853180914513}, "RegExp": {"lowerIsBetter": false, "filtered": 26.092409876543226, "unit": "score", "value": 26.092409876543226}, "Richards": {"lowerIsBetter": false, "filtered": 39.39294105894105, "unit": "score", "value": 39.39294105894105}, "Earley": {"lowerIsBetter": false, "filtered": 669.126188811189, "unit": "score", "value": 669.126188811189}, "Boyer": {"lowerIsBetter": false, "filtered": 39.94783216783217, "unit": "score", "value": 39.94783216783217}, "RayTrace": {"lowerIsBetter": false, "filtered": 537.4345684315684, "unit": "score", "value": 537.4345684315684}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0062.e"}, "testrun": {"date": 1447650875, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151115191934", "branch": "Fx-Team", "revision": "04fb61e343addd47b88ac694041c0bce5a98cfc0"}}] 21:34:52 INFO - RETURN: dromaeo_css: 5648.30 21:34:52 INFO - RETURN: kraken: 1952.60 21:34:52 INFO - RETURN: v8_7: 13577.83 21:34:52 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,57]]", "result": "13577.83"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,57]]", "result": "1952.60"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,57]]", "result": "5648.30"}}} 21:34:52 INFO - Return code: 0 21:34:52 INFO - # TBPL SUCCESS # 21:34:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:34:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:34:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:34:52 INFO - 2015-11-15 21:34:52.105 screenresolution[2878:27758] starting screenresolution argv=screenresolution get 21:34:52 INFO - 2015-11-15 21:34:52.108 screenresolution[2878:27758] Display 0: 1600x1200x32@60 21:34:52 INFO - 2015-11-15 21:34:52.115 screenresolution[2879:27762] starting screenresolution argv=screenresolution list 21:34:52 INFO - Available Modes on Display 0 21:34:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:34:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:34:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:34:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:34:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:34:52 INFO - Intel HD Graphics 3000: 21:34:52 INFO - Chipset Model: Intel HD Graphics 3000 21:34:52 INFO - Type: GPU 21:34:52 INFO - Bus: Built-In 21:34:52 INFO - VRAM (Total): 512 MB 21:34:52 INFO - VRAM (Dynamic, Max): 10 21:34:52 INFO - Vendor: Intel (0x8086) 21:34:52 INFO - Device ID: 0x0116 21:34:52 INFO - Revision ID: 0x0009 21:34:52 INFO - Displays: 21:34:52 INFO - Display: 21:34:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:34:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:34:52 INFO - Display Serial Number: 1600x1200 60 21:34:52 INFO - Main Display: Yes 21:34:52 INFO - Mirror: Off 21:34:52 INFO - Online: Yes 21:34:52 INFO - Rotation: Supported 21:34:52 INFO - Return code: 0 21:34:52 INFO - Running post-action listener: _resource_record_post_action 21:34:52 INFO - Running post-run listener: _resource_record_post_run 21:34:53 INFO - Total resource usage - Wall time: 1260s; CPU: 30.0%; Read bytes: 0; Write bytes: 688497664; Read time: 0; Write time: 49254 21:34:53 INFO - install - Wall time: 43s; CPU: 30.0%; Read bytes: 342012416; Write bytes: 344905728; Read time: 38011; Write time: 5082 21:34:53 INFO - run-tests - Wall time: 1218s; CPU: 30.0%; Read bytes: 0; Write bytes: 341785600; Read time: 0; Write time: 44154 21:34:53 INFO - Running post-run listener: _upload_blobber_files 21:34:53 INFO - Blob upload gear active. 21:34:53 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 21:34:53 INFO - Copying logs to upload dir... 21:34:53 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1317.350510 ========= master_lag: 2.86 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 0 secs) (at 2015-11-15 21:34:56.392285) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 21:34:56.398136) ========= 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.fcd0Vvo1Kh/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.Tri4sMhelj/Listeners TMPDIR=/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/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:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010261 build_url: 'https://queue.taskcluster.net/v1/task/ZjTbuTY2RkSkT863-Sdzjw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.43 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-15 21:34:56.840810) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:34:56.841140) ========= 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.fcd0Vvo1Kh/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.Tri4sMhelj/Listeners TMPDIR=/var/folders/6j/3r32w10n3czgggq39z1pn4jm00000w/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:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005657 ========= master_lag: 0.02 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-15 21:34:56.865818) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 21:34:56.866145) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-15 21:34:56.866548) ========= ========= Total master_lag: 3.50 =========