builder: mozilla-central_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0034 starttime: 1447767102.69 results: success (0) buildid: 20151117032807 builduid: d030115b0bb748bc9c95c5a4fd1d465b revision: f8b569906e4c257687664227f470e416872d5802 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:42.687795) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:42.688279) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:42.688598) ========= 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.8J8aS6cGgO/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.nInnzzQjiH/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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.006144 basedir: '/builds/slave/test' ========= master_lag: 0.06 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:42.749759) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:42.750595) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:42.777488) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:42.777823) ========= 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.8J8aS6cGgO/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.nInnzzQjiH/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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.015248 ========= master_lag: 0.16 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:42.948104) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:42.948538) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:42.949018) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:42.949398) ========= 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.8J8aS6cGgO/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.nInnzzQjiH/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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-17 05:31:42-- 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% 1.26G=0s 2015-11-17 05:31:43 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.232079 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:43.201482) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:43.202114) ========= 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.8J8aS6cGgO/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.nInnzzQjiH/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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.138394 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:43.357222) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:43.357710) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev f8b569906e4c257687664227f470e416872d5802 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev f8b569906e4c257687664227f470e416872d5802 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8J8aS6cGgO/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.nInnzzQjiH/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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-17 05:31:43,447 truncating revision to first 12 chars 2015-11-17 05:31:43,447 Setting DEBUG logging. 2015-11-17 05:31:43,447 attempt 1/10 2015-11-17 05:31:43,447 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/f8b569906e4c?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-17 05:31:43,713 unpacking tar archive at: mozilla-central-f8b569906e4c/testing/mozharness/ program finished with exit code 0 elapsedTime=0.535958 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:43.914952) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:43.915671) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:43.930764) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:43.931237) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-17 05:31:43.931912) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2015-11-17 05:31:43.932315) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.8J8aS6cGgO/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.nInnzzQjiH/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 05:31:44 INFO - MultiFileLogger online at 20151117 05:31:44 in /builds/slave/test 05:31:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:31:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:31:44 INFO - {'append_to_log': False, 05:31:44 INFO - 'base_work_dir': '/builds/slave/test', 05:31:44 INFO - 'blob_upload_branch': 'Firefox', 05:31:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:31:44 INFO - 'branch': 'Firefox', 05:31:44 INFO - 'buildbot_json_path': 'buildprops.json', 05:31:44 INFO - 'config_files': ('talos/mac_config.py',), 05:31:44 INFO - 'default_actions': ('clobber', 05:31:44 INFO - 'read-buildbot-config', 05:31:44 INFO - 'download-and-extract', 05:31:44 INFO - 'populate-webroot', 05:31:44 INFO - 'create-virtualenv', 05:31:44 INFO - 'install', 05:31:44 INFO - 'run-tests'), 05:31:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:31:44 INFO - 'download_minidump_stackwalk': True, 05:31:44 INFO - 'download_symbols': 'ondemand', 05:31:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:31:44 INFO - 'tooltool.py': '/tools/tooltool.py', 05:31:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:31:44 INFO - '/tools/misc-python/virtualenv.py')}, 05:31:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:31:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:31:44 INFO - 'installer_path': 'installer.exe', 05:31:44 INFO - 'log_level': 'info', 05:31:44 INFO - 'log_name': 'talos', 05:31:44 INFO - 'log_to_console': True, 05:31:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:31:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:31:44 INFO - 'opt_config_files': (), 05:31:44 INFO - 'pip_index': False, 05:31:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:44 INFO - 'cmd': ('bash', 05:31:44 INFO - '-c', 05:31:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:44 INFO - 'enabled': True, 05:31:44 INFO - 'halt_on_failure': False, 05:31:44 INFO - 'name': 'check_screen_resolution'},), 05:31:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:31:44 INFO - 'cmd': ('bash', 05:31:44 INFO - '-c', 05:31:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:31:44 INFO - 'enabled': True, 05:31:44 INFO - 'halt_on_failure': False, 05:31:44 INFO - 'name': 'check_screen_resolution'},), 05:31:44 INFO - 'run_cmd_checks_enabled': True, 05:31:44 INFO - 'sps_profile': False, 05:31:44 INFO - 'sps_profile_interval': 0, 05:31:44 INFO - 'suite': 'dromaeojs-e10s', 05:31:44 INFO - 'system_bits': '64', 05:31:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:31:44 INFO - 'title': 't-yosemite-r5-0034', 05:31:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:31:44 INFO - 'use_talos_json': True, 05:31:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:31:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:31:44 INFO - 'work_dir': 'build'} 05:31:44 INFO - ##### 05:31:44 INFO - ##### Running clobber step. 05:31:44 INFO - ##### 05:31:44 INFO - Running pre-action listener: _resource_record_pre_action 05:31:44 INFO - Running main action method: clobber 05:31:44 INFO - rmtree: /builds/slave/test/build 05:31:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:31:48 INFO - Running post-action listener: _resource_record_post_action 05:31:48 INFO - ##### 05:31:48 INFO - ##### Running read-buildbot-config step. 05:31:48 INFO - ##### 05:31:48 INFO - Running pre-action listener: _resource_record_pre_action 05:31:48 INFO - Running main action method: read_buildbot_config 05:31:48 INFO - Using buildbot properties: 05:31:48 INFO - { 05:31:48 INFO - "properties": { 05:31:48 INFO - "buildnumber": 20, 05:31:48 INFO - "product": "firefox", 05:31:48 INFO - "script_repo_revision": "production", 05:31:48 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs-e10s", 05:31:48 INFO - "repository": "", 05:31:48 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs-e10s", 05:31:48 INFO - "buildid": "20151117032807", 05:31:48 INFO - "slavename": "t-yosemite-r5-0034", 05:31:48 INFO - "pgo_build": "False", 05:31:48 INFO - "basedir": "/builds/slave/test", 05:31:48 INFO - "project": "", 05:31:48 INFO - "platform": "yosemite", 05:31:48 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:31:48 INFO - "slavebuilddir": "test", 05:31:48 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:31:48 INFO - "branch": "mozilla-central", 05:31:48 INFO - "repo_path": "mozilla-central", 05:31:48 INFO - "stage_platform": "macosx64", 05:31:48 INFO - "builduid": "d030115b0bb748bc9c95c5a4fd1d465b", 05:31:48 INFO - "revision": "f8b569906e4c257687664227f470e416872d5802" 05:31:48 INFO - }, 05:31:48 INFO - "sourcestamp": { 05:31:48 INFO - "repository": "", 05:31:48 INFO - "hasPatch": false, 05:31:48 INFO - "project": "", 05:31:48 INFO - "branch": "mozilla-central-macosx64-talos", 05:31:48 INFO - "changes": [ 05:31:48 INFO - { 05:31:48 INFO - "category": null, 05:31:48 INFO - "files": [ 05:31:48 INFO - { 05:31:48 INFO - "url": null, 05:31:48 INFO - "name": "https://queue.taskcluster.net/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:31:48 INFO - } 05:31:48 INFO - ], 05:31:48 INFO - "repository": "", 05:31:48 INFO - "rev": "f8b569906e4c257687664227f470e416872d5802", 05:31:48 INFO - "who": "cbook@mozilla.com", 05:31:48 INFO - "when": 1447766471, 05:31:48 INFO - "number": 6671773, 05:31:48 INFO - "comments": "merge mozilla-inbound to mozilla-central a=merge", 05:31:48 INFO - "project": "", 05:31:48 INFO - "at": "Tue 17 Nov 2015 05:21:11", 05:31:48 INFO - "branch": "mozilla-central-macosx64-talos", 05:31:48 INFO - "revlink": "", 05:31:48 INFO - "properties": [ 05:31:48 INFO - [ 05:31:48 INFO - "buildid", 05:31:48 INFO - "20151117032807", 05:31:48 INFO - "Change" 05:31:48 INFO - ], 05:31:48 INFO - [ 05:31:48 INFO - "builduid", 05:31:48 INFO - "d030115b0bb748bc9c95c5a4fd1d465b", 05:31:48 INFO - "Change" 05:31:48 INFO - ], 05:31:48 INFO - [ 05:31:48 INFO - "pgo_build", 05:31:48 INFO - "False", 05:31:48 INFO - "Change" 05:31:48 INFO - ] 05:31:48 INFO - ], 05:31:48 INFO - "revision": "f8b569906e4c257687664227f470e416872d5802" 05:31:48 INFO - } 05:31:48 INFO - ], 05:31:48 INFO - "revision": "f8b569906e4c257687664227f470e416872d5802" 05:31:48 INFO - } 05:31:48 INFO - } 05:31:48 INFO - Found installer url https://queue.taskcluster.net/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:31:48 INFO - Running post-action listener: _resource_record_post_action 05:31:48 INFO - ##### 05:31:48 INFO - ##### Running download-and-extract step. 05:31:48 INFO - ##### 05:31:48 INFO - Running pre-action listener: _resource_record_pre_action 05:31:48 INFO - Running main action method: download_and_extract 05:31:48 INFO - mkdir: /builds/slave/test/build/tests 05:31:48 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')]} 05:31:48 INFO - https://queue.taskcluster.net/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:31:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/test_packages.json 05:31:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/test_packages.json 05:31:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:31:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:31:48 INFO - Downloaded 1149 bytes. 05:31:48 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:31:48 INFO - Using the following test package requirements: 05:31:48 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:31:48 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:31:48 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:31:48 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:31:48 INFO - u'jsshell-mac.zip'], 05:31:48 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:31:48 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:31:48 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:31:48 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:31:48 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:31:48 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:31:48 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:31:48 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:31:48 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:31:48 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:31:48 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:31:48 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:31:48 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:31:48 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')]} 05:31:48 INFO - https://queue.taskcluster.net/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:31:48 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:31:48 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:31:48 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/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 05:31:48 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/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 05:31:49 INFO - Downloaded 17461061 bytes. 05:31:49 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 05:31:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:31:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:31:55 INFO - Return code: 0 05:31:55 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 05:31:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:31:55 INFO - https://queue.taskcluster.net/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:31:55 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:31:55 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:31:55 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/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 05:31:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/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 05:31:56 INFO - Downloaded 17461061 bytes. 05:31:56 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 05:31:56 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:31:56 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:32:02 INFO - Return code: 0 05:32:02 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')]} 05:32:02 INFO - https://queue.taskcluster.net/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:32:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:32:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:32:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/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 05:32:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/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 05:32:04 INFO - Downloaded 11131693 bytes. 05:32:04 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 05:32:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:32:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:32:04 INFO - Return code: 0 05:32:04 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')]} 05:32:04 INFO - https://queue.taskcluster.net/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:32:04 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:32:04 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:32:04 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:32:04 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/hQjDk-86TxurJrYTUPbQMQ/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 05:32:09 INFO - Downloaded 108801755 bytes. 05:32:09 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:32:09 INFO - mkdir: /builds/slave/test/properties 05:32:09 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:32:09 INFO - Writing to file /builds/slave/test/properties/build_url 05:32:09 INFO - Contents: 05:32:09 INFO - build_url:https://queue.taskcluster.net/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:32:09 INFO - Running post-action listener: _resource_record_post_action 05:32:09 INFO - Running post-action listener: set_extra_try_arguments 05:32:09 INFO - ##### 05:32:09 INFO - ##### Running populate-webroot step. 05:32:09 INFO - ##### 05:32:09 INFO - Running pre-action listener: _resource_record_pre_action 05:32:09 INFO - Running main action method: populate_webroot 05:32:09 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:32:09 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:32:09 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:32:09 INFO - '../fennec_ids.txt'], 05:32:09 INFO - 'tests': ['tcheck2']}, 05:32:09 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:32:09 INFO - '--tppagecycles', 05:32:09 INFO - '7'], 05:32:09 INFO - 'tests': ['tsvgm']}}, 05:32:09 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:32:09 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:32:09 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:32:09 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:32:09 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:32:09 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:32:09 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:09 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:09 INFO - 'talos_options': ['--e10s'], 05:32:09 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:32:09 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:09 INFO - 'tests': ['damp', 'tps']}, 05:32:09 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:09 INFO - 'talos_options': ['--e10s'], 05:32:09 INFO - 'tests': ['damp', 'tps']}, 05:32:09 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:32:09 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:32:09 INFO - 'other': {'tests': ['a11yr', 05:32:09 INFO - 'ts_paint', 05:32:09 INFO - 'tpaint', 05:32:09 INFO - 'sessionrestore', 05:32:09 INFO - 'sessionrestore_no_auto_restore']}, 05:32:09 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:32:09 INFO - 'tests': ['a11yr', 05:32:09 INFO - 'ts_paint', 05:32:09 INFO - 'tpaint', 05:32:09 INFO - 'sessionrestore', 05:32:09 INFO - 'sessionrestore_no_auto_restore']}, 05:32:09 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:32:09 INFO - 'tests': ['a11yr', 05:32:09 INFO - 'ts_paint', 05:32:09 INFO - 'tpaint', 05:32:09 INFO - 'sessionrestore', 05:32:09 INFO - 'sessionrestore_no_auto_restore']}, 05:32:09 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:32:09 INFO - 'tests': ['a11yr', 05:32:09 INFO - 'ts_paint', 05:32:09 INFO - 'tpaint', 05:32:09 INFO - 'sessionrestore', 05:32:09 INFO - 'sessionrestore_no_auto_restore']}, 05:32:09 INFO - 'other_l64': {'tests': ['a11yr', 05:32:09 INFO - 'ts_paint', 05:32:09 INFO - 'tpaint', 05:32:09 INFO - 'sessionrestore', 05:32:09 INFO - 'sessionrestore_no_auto_restore']}, 05:32:09 INFO - 'other_nol64': {'tests': ['a11yr', 05:32:09 INFO - 'ts_paint', 05:32:09 INFO - 'tpaint', 05:32:09 INFO - 'sessionrestore', 05:32:09 INFO - 'sessionrestore_no_auto_restore']}, 05:32:09 INFO - 'svgr': {'tests': ['tsvgx', 05:32:09 INFO - 'tsvgr_opacity', 05:32:09 INFO - 'tart', 05:32:09 INFO - 'tscrollx', 05:32:09 INFO - 'cart']}, 05:32:09 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:32:09 INFO - 'tests': ['tsvgx', 05:32:09 INFO - 'tsvgr_opacity', 05:32:09 INFO - 'tart', 05:32:09 INFO - 'tscrollx', 05:32:09 INFO - 'cart']}, 05:32:09 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:09 INFO - 'tests': ['tp5o']}, 05:32:09 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:09 INFO - 'talos_options': ['--e10s'], 05:32:09 INFO - 'tests': ['tp5o']}, 05:32:09 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:09 INFO - 'talos_options': ['--xperf_path', 05:32:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:09 INFO - 'tests': ['tp5n']}, 05:32:09 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:32:09 INFO - 'talos_options': ['--e10s', 05:32:09 INFO - '--xperf_path', 05:32:09 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:32:09 INFO - 'tests': ['tp5n']}}, 05:32:09 INFO - 'talos.zip': {'path': '', 05:32:09 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:32:09 INFO - Running post-action listener: _resource_record_post_action 05:32:09 INFO - ##### 05:32:09 INFO - ##### Running create-virtualenv step. 05:32:09 INFO - ##### 05:32:09 INFO - Running pre-action listener: _resource_record_pre_action 05:32:09 INFO - Running main action method: create_virtualenv 05:32:09 INFO - Creating virtualenv /builds/slave/test/build/venv 05:32:09 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 05:32:09 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:32:09 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:32:09 INFO - Using real prefix '/tools/python27' 05:32:09 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:32:10 INFO - Installing distribute.............................................................................................................................................................................................done. 05:32:14 INFO - Installing pip.................done. 05:32:14 INFO - Return code: 0 05:32:14 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:14 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 0x10f3a1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f37e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b52cae040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c49f0>, '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 0x10f024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b88c8>, '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.8J8aS6cGgO/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.nInnzzQjiH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 05:32:14 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 05:32:14 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 05:32:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8J8aS6cGgO/Render', 05:32:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:14 INFO - 'HOME': '/Users/cltbld', 05:32:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:14 INFO - 'LOGNAME': 'cltbld', 05:32:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:14 INFO - 'MOZ_NO_REMOTE': '1', 05:32:14 INFO - 'NO_EM_RESTART': '1', 05:32:14 INFO - 'PAGER': '/bin/cat', 05:32:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:14 INFO - 'PWD': '/builds/slave/test', 05:32:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:14 INFO - 'SHELL': '/bin/bash', 05:32:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nInnzzQjiH/Listeners', 05:32:14 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 05:32:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:14 INFO - 'USER': 'cltbld', 05:32:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:14 INFO - 'XPC_FLAGS': '0x0', 05:32:14 INFO - 'XPC_SERVICE_NAME': '0', 05:32:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:15 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 05:32:15 INFO - Cleaning up... 05:32:15 INFO - Return code: 0 05:32:15 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:32:15 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')]} 05:32:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:15 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')]} 05:32:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:15 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 0x10f3a1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f37e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b52cae040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c49f0>, '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 0x10f024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b88c8>, '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.8J8aS6cGgO/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.nInnzzQjiH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 05:32:15 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 05:32:15 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 05:32:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8J8aS6cGgO/Render', 05:32:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:15 INFO - 'HOME': '/Users/cltbld', 05:32:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:15 INFO - 'LOGNAME': 'cltbld', 05:32:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:15 INFO - 'MOZ_NO_REMOTE': '1', 05:32:15 INFO - 'NO_EM_RESTART': '1', 05:32:15 INFO - 'PAGER': '/bin/cat', 05:32:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:15 INFO - 'PWD': '/builds/slave/test', 05:32:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:15 INFO - 'SHELL': '/bin/bash', 05:32:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nInnzzQjiH/Listeners', 05:32:15 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 05:32:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:15 INFO - 'USER': 'cltbld', 05:32:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:15 INFO - 'XPC_FLAGS': '0x0', 05:32:15 INFO - 'XPC_SERVICE_NAME': '0', 05:32:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:32:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:15 INFO - Downloading/unpacking psutil>=0.7.1 05:32:15 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 05:32:15 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 05:32:15 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 05:32:15 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 05:32:15 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 05:32:15 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 05:32:18 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:32:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:32:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:32:18 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:18 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:18 INFO - Installing collected packages: psutil 05:32:18 INFO - Running setup.py install for psutil 05:32:18 INFO - building 'psutil._psutil_osx' extension 05:32:18 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 05:32:20 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 05:32:20 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 05:32:20 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 05:32:20 INFO - building 'psutil._psutil_posix' extension 05:32:20 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 05:32:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:32:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:32:21 INFO - ^ 05:32:21 INFO - 1 warning generated. 05:32:21 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 05:32:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:32:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:32:21 INFO - Successfully installed psutil 05:32:21 INFO - Cleaning up... 05:32:21 INFO - Return code: 0 05:32:21 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:32:21 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')]} 05:32:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:21 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')]} 05:32:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:21 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 0x10f3a1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f37e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b52cae040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c49f0>, '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 0x10f024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b88c8>, '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.8J8aS6cGgO/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.nInnzzQjiH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 05:32:21 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 05:32:21 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 05:32:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8J8aS6cGgO/Render', 05:32:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:21 INFO - 'HOME': '/Users/cltbld', 05:32:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:21 INFO - 'LOGNAME': 'cltbld', 05:32:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:21 INFO - 'MOZ_NO_REMOTE': '1', 05:32:21 INFO - 'NO_EM_RESTART': '1', 05:32:21 INFO - 'PAGER': '/bin/cat', 05:32:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:21 INFO - 'PWD': '/builds/slave/test', 05:32:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:21 INFO - 'SHELL': '/bin/bash', 05:32:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nInnzzQjiH/Listeners', 05:32:21 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 05:32:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:21 INFO - 'USER': 'cltbld', 05:32:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:21 INFO - 'XPC_FLAGS': '0x0', 05:32:21 INFO - 'XPC_SERVICE_NAME': '0', 05:32:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:32:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:21 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:32:21 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 05:32:21 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 05:32:21 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 05:32:21 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 05:32:21 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 05:32:21 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 05:32:24 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:32:24 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:32:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:32:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:32:24 INFO - Installing collected packages: mozsystemmonitor 05:32:24 INFO - Running setup.py install for mozsystemmonitor 05:32:24 INFO - Successfully installed mozsystemmonitor 05:32:24 INFO - Cleaning up... 05:32:24 INFO - Return code: 0 05:32:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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', '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 0x10f3a1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f37e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b52cae040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c49f0>, '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 0x10f024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b88c8>, '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.8J8aS6cGgO/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.nInnzzQjiH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 05:32: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:32: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 blobuploader==1.2.4 05:32:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8J8aS6cGgO/Render', 05:32:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:24 INFO - 'HOME': '/Users/cltbld', 05:32:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:24 INFO - 'LOGNAME': 'cltbld', 05:32:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:24 INFO - 'MOZ_NO_REMOTE': '1', 05:32:24 INFO - 'NO_EM_RESTART': '1', 05:32:24 INFO - 'PAGER': '/bin/cat', 05:32:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:24 INFO - 'PWD': '/builds/slave/test', 05:32:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:24 INFO - 'SHELL': '/bin/bash', 05:32:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nInnzzQjiH/Listeners', 05:32:24 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 05:32:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:24 INFO - 'USER': 'cltbld', 05:32:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:24 INFO - 'XPC_FLAGS': '0x0', 05:32:24 INFO - 'XPC_SERVICE_NAME': '0', 05:32:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:32:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:24 INFO - Downloading/unpacking blobuploader==1.2.4 05:32:24 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 05:32:24 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 05:32:24 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 05:32:24 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 05:32:24 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 05:32:24 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 05:32:27 INFO - Downloading blobuploader-1.2.4.tar.gz 05:32:27 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:32:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:32:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:32:27 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 05:32:27 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 05:32:27 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 05:32:27 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 05:32:27 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 05:32:27 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 05:32:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:32:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:28 INFO - Downloading docopt-0.6.1.tar.gz 05:32:28 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:32:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:32:28 INFO - Installing collected packages: blobuploader, requests, docopt 05:32:28 INFO - Running setup.py install for blobuploader 05:32:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:32:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:32:29 INFO - Running setup.py install for requests 05:32:29 INFO - Running setup.py install for docopt 05:32:29 INFO - Successfully installed blobuploader requests docopt 05:32:29 INFO - Cleaning up... 05:32:29 INFO - Return code: 0 05:32:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:29 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 0x10f3a1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f37e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b52cae040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c49f0>, '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 0x10f024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b88c8>, '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.8J8aS6cGgO/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.nInnzzQjiH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 05:32:29 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 05:32:29 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 05:32:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8J8aS6cGgO/Render', 05:32:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:29 INFO - 'HOME': '/Users/cltbld', 05:32:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:29 INFO - 'LOGNAME': 'cltbld', 05:32:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:29 INFO - 'MOZ_NO_REMOTE': '1', 05:32:29 INFO - 'NO_EM_RESTART': '1', 05:32:29 INFO - 'PAGER': '/bin/cat', 05:32:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:29 INFO - 'PWD': '/builds/slave/test', 05:32:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:29 INFO - 'SHELL': '/bin/bash', 05:32:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nInnzzQjiH/Listeners', 05:32:29 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 05:32:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:29 INFO - 'USER': 'cltbld', 05:32:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:29 INFO - 'XPC_FLAGS': '0x0', 05:32:29 INFO - 'XPC_SERVICE_NAME': '0', 05:32:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:32:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:30 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-NKc0v7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:30 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-KbuMYY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:30 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-69BuFM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:30 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-OeaV9Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:30 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-LGTNBQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:30 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-5V5M5C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:31 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-Bz_lUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:31 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-J5tX3G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:31 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-ejmFhd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:31 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-0xeOXO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:31 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-Re3z1t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:31 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-xuNsld-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:31 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-0TRa94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:32 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-nPTbCe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:32 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-AWDgz7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:32 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-2DONOY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:32 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:32 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-V_m6bj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:32 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:32:32 INFO - Running setup.py install for manifestparser 05:32:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:32:32 INFO - Running setup.py install for mozcrash 05:32:32 INFO - Running setup.py install for mozdebug 05:32:33 INFO - Running setup.py install for mozdevice 05:32:33 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:32:33 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:32:33 INFO - Running setup.py install for mozfile 05:32:33 INFO - Running setup.py install for mozhttpd 05:32:33 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:32:33 INFO - Running setup.py install for mozinfo 05:32:33 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:32:33 INFO - Running setup.py install for mozInstall 05:32:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:32:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:32:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:32:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:32:33 INFO - Running setup.py install for mozleak 05:32:34 INFO - Running setup.py install for mozlog 05:32:34 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:32:34 INFO - Running setup.py install for moznetwork 05:32:34 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:32:34 INFO - Running setup.py install for mozprocess 05:32:34 INFO - Running setup.py install for mozprofile 05:32:34 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:32:34 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:32:34 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:32:34 INFO - Running setup.py install for mozrunner 05:32:35 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:32:35 INFO - Running setup.py install for mozscreenshot 05:32:35 INFO - Running setup.py install for moztest 05:32:35 INFO - Running setup.py install for mozversion 05:32:35 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:32:35 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:32:35 INFO - Cleaning up... 05:32:35 INFO - Return code: 0 05:32:35 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32: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')]} 05:32:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32: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')]} 05:32:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:35 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 0x10f3a1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f37e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b52cae040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c49f0>, '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 0x10f024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b88c8>, '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.8J8aS6cGgO/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.nInnzzQjiH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 05:32:35 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 05:32:35 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 05:32:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8J8aS6cGgO/Render', 05:32:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:35 INFO - 'HOME': '/Users/cltbld', 05:32:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:35 INFO - 'LOGNAME': 'cltbld', 05:32:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:35 INFO - 'MOZ_NO_REMOTE': '1', 05:32:35 INFO - 'NO_EM_RESTART': '1', 05:32:35 INFO - 'PAGER': '/bin/cat', 05:32:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:35 INFO - 'PWD': '/builds/slave/test', 05:32:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:35 INFO - 'SHELL': '/bin/bash', 05:32:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nInnzzQjiH/Listeners', 05:32:35 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 05:32:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:35 INFO - 'USER': 'cltbld', 05:32:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:35 INFO - 'XPC_FLAGS': '0x0', 05:32:35 INFO - 'XPC_SERVICE_NAME': '0', 05:32:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:32:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:32:36 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-mZBX1h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:32:36 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)) 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:32:36 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-xHzKok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:32:36 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)) 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:32:36 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-fFKnRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:32:36 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-aZxKJp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:32:36 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)) 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:32:36 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-wIKsUS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:32:36 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-fBU_ok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:32:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:32:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:32:36 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-zsN5kk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:32:37 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)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:32:37 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-CwsjHB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:32:37 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)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:32:37 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-eeSDoc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:32:37 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)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:32:37 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-avhVGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:32:37 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)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:32:37 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-hAneRQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:32:37 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)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:32:37 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-nT9kgg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:32:37 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-QURVCx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:32:37 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)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:32:37 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-MfXB8d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:32:37 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:32:37 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:37 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-xWYrhj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:32:38 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)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:32:38 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-4DcOuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:32:38 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)) 05:32:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:32:38 INFO - Running setup.py (path:/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/pip-ljovpC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:32:38 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)) 05:32:38 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)) 05:32:38 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)) 05:32:38 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)) 05:32:38 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)) 05:32:38 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)) 05:32:38 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:32:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:32:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:32:40 INFO - Downloading blessings-1.5.1.tar.gz 05:32:40 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 05:32:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:32:41 INFO - Installing collected packages: blessings 05:32:41 INFO - Running setup.py install for blessings 05:32:41 INFO - Successfully installed blessings 05:32:41 INFO - Cleaning up... 05:32:41 INFO - Return code: 0 05:32:41 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:41 INFO - Reading from file tmpfile_stdout 05:32:41 INFO - Current package versions: 05:32:41 INFO - blessings == 1.5.1 05:32:41 INFO - blobuploader == 1.2.4 05:32:41 INFO - docopt == 0.6.1 05:32:41 INFO - manifestparser == 1.1 05:32:41 INFO - mozInstall == 1.12 05:32:41 INFO - mozcrash == 0.16 05:32:41 INFO - mozdebug == 0.1 05:32:41 INFO - mozdevice == 0.47 05:32:41 INFO - mozfile == 1.2 05:32:41 INFO - mozhttpd == 0.7 05:32:41 INFO - mozinfo == 0.9 05:32:41 INFO - mozleak == 0.1 05:32:41 INFO - mozlog == 3.0 05:32:41 INFO - moznetwork == 0.27 05:32:41 INFO - mozprocess == 0.22 05:32:41 INFO - mozprofile == 0.27 05:32:41 INFO - mozrunner == 6.11 05:32:41 INFO - mozscreenshot == 0.1 05:32:41 INFO - mozsystemmonitor == 0.0 05:32:41 INFO - moztest == 0.7 05:32:41 INFO - mozversion == 1.4 05:32:41 INFO - psutil == 3.1.1 05:32:41 INFO - requests == 1.2.3 05:32:41 INFO - wsgiref == 0.1.2 05:32:41 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:32:41 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 0x10f3a1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f37e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8b52cae040>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f2c49f0>, '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 0x10f024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b88c8>, '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.8J8aS6cGgO/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.nInnzzQjiH/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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 05:32:41 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 05:32:41 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 05:32:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8J8aS6cGgO/Render', 05:32:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:32:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:32:41 INFO - 'HOME': '/Users/cltbld', 05:32:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:32:41 INFO - 'LOGNAME': 'cltbld', 05:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:32:41 INFO - 'MOZ_NO_REMOTE': '1', 05:32:41 INFO - 'NO_EM_RESTART': '1', 05:32:41 INFO - 'PAGER': '/bin/cat', 05:32:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:32:41 INFO - 'PWD': '/builds/slave/test', 05:32:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:32:41 INFO - 'SHELL': '/bin/bash', 05:32:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nInnzzQjiH/Listeners', 05:32:41 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 05:32:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:32:41 INFO - 'USER': 'cltbld', 05:32:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:32:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:32:41 INFO - 'XPC_FLAGS': '0x0', 05:32:41 INFO - 'XPC_SERVICE_NAME': '0', 05:32:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:32:42 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)) 05:32:42 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)) 05:32:42 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)) 05:32:42 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)) 05:32:42 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)) 05:32:42 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)) 05:32:42 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)) 05:32:42 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)) 05:32:42 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)) 05:32:42 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)) 05:32:42 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)) 05:32:42 INFO - Cleaning up... 05:32:42 INFO - Return code: 0 05:32:42 INFO - Running post-action listener: _resource_record_post_action 05:32:42 INFO - Running post-action listener: _start_resource_monitoring 05:32:42 INFO - Starting resource monitoring. 05:32:42 INFO - ##### 05:32:42 INFO - ##### Running install step. 05:32:42 INFO - ##### 05:32:42 INFO - Running pre-action listener: _resource_record_pre_action 05:32:42 INFO - Running main action method: install 05:32:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:32:42 INFO - Reading from file tmpfile_stdout 05:32:42 INFO - Detecting whether we're running mozinstall >=1.0... 05:32:42 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:32:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:32:42 INFO - Reading from file tmpfile_stdout 05:32:42 INFO - Output received: 05:32:42 INFO - Usage: mozinstall [options] installer 05:32:42 INFO - Options: 05:32:42 INFO - -h, --help show this help message and exit 05:32:42 INFO - -d DEST, --destination=DEST 05:32:42 INFO - Directory to install application into. [default: 05:32:42 INFO - "/builds/slave/test"] 05:32:42 INFO - --app=APP Application being installed. [default: firefox] 05:32:42 INFO - mkdir: /builds/slave/test/build/application 05:32:42 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'] 05:32:42 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 05:33:23 INFO - Reading from file tmpfile_stdout 05:33:23 INFO - Output received: 05:33:23 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:33:23 INFO - Running post-action listener: _resource_record_post_action 05:33:23 INFO - ##### 05:33:23 INFO - ##### Running run-tests step. 05:33:23 INFO - ##### 05:33:23 INFO - Running pre-action listener: _resource_record_pre_action 05:33:23 INFO - Running main action method: run_tests 05:33:23 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:33:23 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:33:23 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:33:23 INFO - 2015-11-17 05:33:23.061 screenresolution[1631:7599] starting screenresolution argv=screenresolution get 05:33:23 INFO - 2015-11-17 05:33:23.065 screenresolution[1631:7599] Display 0: 1600x1200x32@60 05:33:23 INFO - 2015-11-17 05:33:23.072 screenresolution[1632:7601] starting screenresolution argv=screenresolution list 05:33:23 INFO - Available Modes on Display 0 05:33:23 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:33:23 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:33:23 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:33:23 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:33:23 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:33:23 INFO - Intel HD Graphics 3000: 05:33:23 INFO - Chipset Model: Intel HD Graphics 3000 05:33:23 INFO - Type: GPU 05:33:23 INFO - Bus: Built-In 05:33:23 INFO - VRAM (Total): 512 MB 05:33:23 INFO - VRAM (Dynamic, Max): 10 05:33:23 INFO - Vendor: Intel (0x8086) 05:33:23 INFO - Device ID: 0x0116 05:33:23 INFO - Revision ID: 0x0009 05:33:23 INFO - Displays: 05:33:23 INFO - Display: 05:33:23 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:33:23 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:33:23 INFO - Display Serial Number: 1600x1200 60 05:33:23 INFO - Main Display: Yes 05:33:23 INFO - Mirror: Off 05:33:23 INFO - Online: Yes 05:33:23 INFO - Rotation: Supported 05:33:23 INFO - Return code: 0 05:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:33:23 INFO - Python 2.7.3 05:33:23 INFO - Return code: 0 05:33:23 INFO - grabbing minidump binary from tooltool 05:33:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:33:23 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 0x10f2c49f0>, '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 0x10f024db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f2b88c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:33:23 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 05:33:23 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 05:33:23 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:33:23 INFO - Return code: 0 05:33:23 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:33:23 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:33:23 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:33:23 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:33:23 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:33:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0034', '--webServer', 'localhost'] in /builds/slave/test/build 05:33:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0034 --webServer localhost 05:33:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.8J8aS6cGgO/Render', 05:33:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:33:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:33:23 INFO - 'HOME': '/Users/cltbld', 05:33:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:33:23 INFO - 'LOGNAME': 'cltbld', 05:33:23 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:33:23 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:33:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:33:23 INFO - 'MOZ_NO_REMOTE': '1', 05:33:23 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:33:23 INFO - 'NO_EM_RESTART': '1', 05:33:23 INFO - 'PAGER': '/bin/cat', 05:33:23 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:33:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:33:23 INFO - 'PWD': '/builds/slave/test', 05:33:23 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:33:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:33:23 INFO - 'SHELL': '/bin/bash', 05:33:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nInnzzQjiH/Listeners', 05:33:23 INFO - 'TMPDIR': '/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/', 05:33:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:33:23 INFO - 'USER': 'cltbld', 05:33:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:33:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:33:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:33:23 INFO - 'XPC_FLAGS': '0x0', 05:33:23 INFO - 'XPC_SERVICE_NAME': '0', 05:33:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:33:23 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0034', '--webServer', 'localhost'] with output_timeout 3600 05:33:23 INFO - mozversion INFO | application_buildid: 20151117032807 05:33:23 INFO - mozversion INFO | application_changeset: f8b569906e4c257687664227f470e416872d5802 05:33:23 INFO - mozversion INFO | application_display_name: Nightly 05:33:23 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:33:23 INFO - mozversion INFO | application_name: Firefox 05:33:23 INFO - mozversion INFO | application_remotingname: firefox 05:33:23 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:33:23 INFO - mozversion INFO | application_vendor: Mozilla 05:33:23 INFO - mozversion INFO | application_version: 45.0a1 05:33:23 INFO - mozversion INFO | platform_buildid: 20151117032807 05:33:23 INFO - mozversion INFO | platform_changeset: f8b569906e4c257687664227f470e416872d5802 05:33:23 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:33:23 INFO - mozversion INFO | platform_version: 45.0a1 05:33:23 INFO - 2015-11-17 05:33:23,818 DEBUG : using testdate: 1447767203 05:33:23 INFO - 2015-11-17 05:33:23,819 DEBUG : actual date: 1447767203 05:33:23 INFO - 2015-11-17 05:33:23,868 INFO : starting webserver on 'localhost:49276' 05:33:23 INFO - 2015-11-17 05:33:23,869 INFO : Starting test suite t-yosemite-r5-0034.e 05:33:23 INFO - 2015-11-17 05:33:23,869 INFO : Starting test dromaeo_css 05:33:23 INFO - 2015-11-17 05:33:23,869 DEBUG : operating with platform_type : mac_ 05:33:23 INFO - 2015-11-17 05:33:23,870 INFO : Initialising browser for dromaeo_css test... 05:33:23 INFO - 2015-11-17 05:33:23,899 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmpmQ0zYS/profile http://localhost:49276/getInfo.html 05:33:28 INFO - 2015-11-17 05:33:28,284 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:33:28 INFO - 2015-11-17 05:33:28,284 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:33:28 INFO - 2015-11-17 05:33:28,284 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:33:28 INFO - 2015-11-17 05:33:28,285 DEBUG : BROWSER_OUTPUT: __metrics 05:33:28 INFO - 2015-11-17 05:33:28,975 INFO : Browser initialized. 05:33:28 INFO - 2015-11-17 05:33:28,975 INFO : Running cycle 1/1 for dromaeo_css test... 05:33:28 INFO - 2015-11-17 05:33:28,975 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmpmQ0zYS/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:33:41 INFO - 2015-11-17 05:33:41,196 DEBUG : BROWSER_OUTPUT: RSS: Main: 240803840 05:33:41 INFO - 2015-11-17 05:33:41,196 DEBUG : BROWSER_OUTPUT: 05:34:31 INFO - 2015-11-17 05:34:31,050 DEBUG : BROWSER_OUTPUT: 1447767271043 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:36:41 INFO - 2015-11-17 05:36:41,371 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49276/tests/dromaeo/cssquery-ext.html) 05:36:42 INFO - 2015-11-17 05:36:42,377 DEBUG : BROWSER_OUTPUT: RSS: Main: 264564736 05:36:42 INFO - 2015-11-17 05:36:42,378 DEBUG : BROWSER_OUTPUT: 05:39:44 INFO - 2015-11-17 05:39:44,376 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-ext.html (next: http://localhost:49276/tests/dromaeo/cssquery-jquery.html) 05:39:44 INFO - 2015-11-17 05:39:44,956 DEBUG : BROWSER_OUTPUT: RSS: Main: 271364096 05:39:44 INFO - 2015-11-17 05:39:44,956 DEBUG : BROWSER_OUTPUT: 05:42:46 INFO - 2015-11-17 05:42:46,712 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49276/tests/dromaeo/cssquery-mootools.html) 05:42:47 INFO - 2015-11-17 05:42:47,298 DEBUG : BROWSER_OUTPUT: RSS: Main: 273813504 05:42:47 INFO - 2015-11-17 05:42:47,298 DEBUG : BROWSER_OUTPUT: 05:45:49 INFO - 2015-11-17 05:45:49,009 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49276/tests/dromaeo/cssquery-prototype.html) 05:45:49 INFO - 2015-11-17 05:45:49,608 DEBUG : BROWSER_OUTPUT: RSS: Main: 278945792 05:45:49 INFO - 2015-11-17 05:45:49,608 DEBUG : BROWSER_OUTPUT: 05:48:52 INFO - 2015-11-17 05:48:52,288 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49276/tests/dromaeo/cssquery-yui.html) 05:48:52 INFO - 2015-11-17 05:48:52,911 DEBUG : BROWSER_OUTPUT: RSS: Main: 284073984 05:48:52 INFO - 2015-11-17 05:48:52,911 DEBUG : BROWSER_OUTPUT: 05:51:55 INFO - 2015-11-17 05:51:55,348 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/dromaeo/cssquery-yui.html (next: http://localhost:49276/tests/dromaeo/cssquery-dojo.html) 05:51:55 INFO - 2015-11-17 05:51:55,606 DEBUG : BROWSER_OUTPUT: RSS: Main: 288980992 05:51:55 INFO - 2015-11-17 05:51:55,606 DEBUG : BROWSER_OUTPUT: 05:51:55 INFO - 2015-11-17 05:51:55,606 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:51:55 INFO - 2015-11-17 05:51:55,606 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:51:55 INFO - 2015-11-17 05:51:55,606 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:51:55 INFO - 2015-11-17 05:51:55,607 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:51:55 INFO - 2015-11-17 05:51:55,607 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2675.4916565852486;2700.74342937421;2735.617013618095;2749.120281509915;2757.7380148885854;4545.340925565795;4648.674592778507;4664.766761661912;4679.812807487705;4732.858014259569;4475.1497215529025;4555.111753208126;4644;4671.275952227402;4693.6010439112715;4333.198358303708;4376.146651402978;4398.230309695807;4404.097160082176;4526.75102869342;4333.263345231318;4406.86779396617;4410.250257456224;4416.138852923681;4507.887302817423;4172.561881002512;4183.100633363811;4362.760048197348;4405.581469760367;4450.799714012877;4376.584224498668;4387.451568553931;4418;4427.712198707074;4441.222786012435;4393;4414.558544145591;4418.977905110486;4435.334699795057;4438.023634800339;4285.6142947134595;4355.324924636687;4481.663875209372;4552.863414097583;4621.168189725848;4831.106245344622;4874.610031197496;4877.170880950247;4934.5312195341385;4960.156773348539;4930.630202734774;4948.604111671058;4968.22992436173;4985.52637499437;4999.450060493343;4457.665675074382;4491.842785502525;4528.592426681615;4541.886452838706;4622.006268652256;4809.735464549483;4897.7795999180125;5015.899682006412;5026.949730502648;5077.822276220315;4602.286645569942;4735.573798358164;4769.165396055746;4808.35087263222;4845.176320025604;4749.1926372516755;4889.559939605452;4925.285833554186;4965.90068198634;4967.975160124249;4766.523347665206;4919.581835543947;4927.508859476033;4934.9753251233515;4942.802287908516;4701.717896926195;4841.733704646208;4869.586085182728;4930.309756634074;4954;3764.322421964018;3769.246150769857;3830.961690383116;3843.1929294847837;3874.1089549403796;3476.860925562949;3502.176988407722;3520.8063556504126;3529.1177205698577;3542.6280240574883;4450.087732014929;4569.246074397687;4714.858554243378;4740.620750340034;4824.614030877521;4938.135826230396;4975.303457515951;4984.800607975713;5014.398272207285;5028.044671512401;4716.834910778106;4720.716756994591;4721.480637129913;4725;4727.550882666142;4196.181744559782;4307.160103779733;4315.8489452869;4352.260115780325;4399.076193999232;4953.455119936804;5073.010762901273;5073.340465739504;5095.847124586268;5152.149895267389;4918.385201849769;4947.6536642434685;5002.474740152232;5006.224035274393;5033.521815427529;4926.827561035347;4971.353724015999;5030.346055012825;5037.219231019198;5119.180931051014;4869.683470574401;4896;4926.236433352836;4941.160002799461;4987.850364489072;4791.47293797689;4992.775325110306;5015.874603134805;5022;5033.144365457954;4428.468583769968;4563.885902852455;4710.528947105262;4769.499202583679;4770.666053376369;4783.736894470838;4814.109389762905;4833.468318485035;4853.854384368475;4880.92678609814;4489.461264648133;4657.46439159501;4684.110019096361;4725.456572494069;4788.688735232199;4588.403507543998;4802.639802014793;4859.416869975626;4882.707037577615;4924.852254432372;4663.417072865892;4724.196886529367;4755.358026666356;4768.332433459249;4770.522947705341 05:51:55 INFO - 2015-11-17 05:51:55,607 DEBUG : BROWSER_OUTPUT: |1;ext.html;452.3192595144307;484.3775748163606;485.5751217684526;489.18306428264793;508.5931254996003;26743.866280668593;31614.367712645733;31760.20599485014;31835.52246716301;31887;35704.82147589265;35822;35977;36006.2798744025;36173;8059.516429014248;8077.515349079044;8180.918190818105;8184.304334131606;8255.587220638974;7819.882701759449;7966.123726390121;8044.316233120192;8085.4340196186295;8145.022597288334;8003.439759216857;8112.756617301461;8162.632681529316;8179;8198.180181981785;7983.201679832028;8086.757397278091;8126.674933002673;8135.511869287802;8150.3479721622425;7894.131645518988;7955.085165206017;8007;8059.032916050053;8076.8788468173025;33182.17044573881;33769.6623033769;33880.15299617529;34478.82760586181;34643.82678086594;2625.3174174714522;2642.7885769138425;2653.4693061387607;2689.287338855205;2947.7936544441895;23435.4141146471;24719.62920556193;24934.127305544218;25591.104311349012;25815.35461613456;2009.6784514477613;2064.7315848939693;2066.318115022039;2066.762322332921;2137.10241698487;227536;228078;228112;230329.9999999983;233580;46436.303455447516;48841.755791220814;50309.49690503048;50764.23853642198;51031.234531482056;48839.75580122148;49159.50840491549;49194.26208606874;49254.261186082236;49661;11981.940090299493;12134.817977730341;12159.392030398622;12202.633920982385;12206.450709718085;8752.606132724042;8817.955910220408;8843.248323892412;8852.336074794417;8987.505687187137;17478.475645730647;17688.380906668204;17747.556311092067;17758.556036099202;17915.014674193044;7344.155422126417;7653.6938522459595;7680.692772289158;7703.114141873644;7715.421343399267;810.3598157455662;851.2679095977454;853.0360692417529;873.7073080518097;962.1965658674944;24418.51162976766;24444.388890277885;24490.877545612515;24540.631890521658;24560.140395086444;855.461059532503;896.3367108339912;917.2066162769156;942.948137852411;966.1063516247443;12509.687257818627;12636.873631263754;12665.620031399072;12736.299503527394;12841.101122921305;271234;278290;278354;282564;282750;45661.54338456573;46195.53804461913;47023.29465058027;47086.76456617763;47673.04653906902;1160.2458402038574;1176.864660564029;1180.492388273051;1185.5020891225706;1186.2408058842348;23378.415539611648;26585;27135.613119176363;27561;27754.722452775215;44163;44210;44225.55774442343;44736.77631611821;44813;238147;242728;243756;244354;247426;35955;38191.23617527689;39328.606713932495;39415;40217.39673904835;35813.46279805857;36312;36554.81722591476;37463.43804842875;37547;32543.34913301768;33259.83370083134;33340.83329583336;34292.48561271533;34838.303233934676;26526.336841579116;30378.848105760215;30547.389052219274;33516.162095947795;36539;36224.637753622126;36415;36963.07592310106;37458.62541374551;37594;31500.684993149775;32172.83913580417;33069.33861322808;34216.38723499584;34592;25910.74089259083;26234;26357.20928372152;26404.603930941437;26557.203283901516 05:51:55 INFO - 2015-11-17 05:51:55,607 DEBUG : BROWSER_OUTPUT: |2;jquery.html;288.3267570223528;289.095132236101;290.8225982150889;296.1308559378225;297.23610321473814;12627.179233349849;13070;15224.543263702093;15246.92376538117;15793.76309355359;16156.919215403936;16499.91750041248;16549.172541372915;16555.337786488526;16649.66700665986;4418.536053714354;4707.952920470802;4734.337192793012;4737.881552961169;4750.738709370983;3919.529656441231;4026.174634199982;4036.031352475399;4037;4701.412323459567;4011.5988401159943;4052.3718823582244;4057.371107478331;4059.7158198926086;4109.97945010276;3962.0689138052535;4034.5965403459713;4132.855350062763;4159.10579225468;4170.061736109366;3477.3914564951288;3477.5826900771817;3515.3145136698354;3536.840842162109;3542.220711443478;11006.834897476545;11127.165462590337;11396.772064558663;11645.534178632844;11647.941760291229;1613.6207991122078;1654.619437529375;1662.908540030298;1690.923908424124;1799.874008819383;7851.097123830776;8043.11525732169;8242.752717418487;8377.95811020947;8409.747707568722;1265.1080987903506;1302.316283950924;1310.4168644953;1354.539456584766;1367.3778430813957;49352;51745.48254517444;51766.74116629393;51841.22238166393;52705;5476.835694929158;5583;5641.9435805641415;5650.886982260414;5689.43105689436;6419.711112999927;6510.739570417225;6515.283318834924;6517.608943463408;6527.477801775846;4363.345498175299;4399.714018588781;4494.056248187917;4494.910101798011;4497.527759585262;4522.095580883836;4605.631549476034;4608.331791890158;4627.1439783640135;4632.791524381411;2490.3525083478426;2515.4969006198467;2526.456811785475;2540.0601777342504;2568.242368501297;869.426178722053;896.8116695493889;914.1407077347272;939.8214339275515;943.5470973932413;346.1906627716066;361.84621535847685;366.1596635720974;372.5138694004296;386.0503162220968;9729.464879431558;10258.897411025795;10290.279680422298;10302.227332950059;10402.739931501621;391.76102577427747;394.1565050791309;401.27369461275185;404.26222144586245;422.9788510574459;5446.455354464601;5462.317210348707;5486.423925487846;5545.445455454503;5589.273394458694;474821;489616;498964;509653;517269;59640;60764.39235607676;61101.694491527254;61169.38830611726;62091.689541552005;426.67146297351485;429.56184691615005;432.7100842435513;433.9002029533225;439.51653181500734;9209.907900921173;9570.569324380558;9608.087231712976;9631.181349585364;9637.807243855224;27730.44539109166;28713.138605841857;29154.70845291605;29440.55839162457;29563.40873182567;36817.63182368142;37303.81348093351;37633.62366376301;37647.43528847124;37769.81115094407;5354.3574771027725;5375.462453754593;5477.698726570077;5481.314835645544;5488.506034456918;10001.699949001542;10270.794584108127;10334.638287659896;10334.689959301233;10351.378917264989;8634.438761480484;8895.154960278764;8976.775580610538;9074.31942604294;9089.000209976764;8459.788505287417;8714.128587141235;8756.912430875864;8766.605502752263;9019.819603608023;9009.504477253813;9025.232855207118;9067.501287428991;9213.723588292361;9254.953725231331;5317.548008419173;5404.216388623706;5464.371597266365;5464.808731694372;5479;8705.608247628745;8924.107589241024;9007.099290071203;9023.90976090257;9150.771230719285 05:51:55 INFO - 2015-11-17 05:51:55,609 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1226.5584389619735;1263.949442022319;1375.147408606664;1480.7186634539437;1516.6208447888027;6084.604500707451;6120.449159575637;6442.001489769087;6841.9657901710425;6856.82857928552;6376.52176086793;6571.539992200548;6689.431398331148;6693.330666933304;6697.732090716366;1867.9252829886823;1907.2561700936647;1919.7024461208466;1920.8271255586994;1924.9326273580427;1943.222710915638;1974.8518861085404;1986.4735845001087;2008.9698654520193;2016.022229218835;1903.800100989397;1933.719610656454;1945.22191123551;1954.7263383126374;1959.3827944197533;1836.825501577348;1881.0406692586741;1909.5226193451638;1911.149538455388;1913.6268427656612;1907.8282954534159;1915.9137838797149;1917.4631103291101;1919.9136038878144;1920.5870737791442;6566.835829104263;6585.341465853377;6599.868002639968;6609.471242300652;6639.966800165968;3930.1157239621143;4037.354023356278;4074.246264441088;4079.7552146870985;4083.4283200351974;2116.1429621003517;2177.7931096545803;2430.3802530354646;2486.5648511510594;2501.374656335916;739.0613920321161;749.4491548711693;768.6195333309992;770.930616244535;784.4508843809356;8465.195806398382;8506.74479765608;8511.148885111439;8518.957405212996;8538.487690738575;3707.573629032696;3770.2836461072857;3906.0430194602504;3920.666743326792;3922.2547715933883;7520.323170914535;7583.810404739926;7615.5430674159725;7622.885656715153;7624.161342252348;4230.471191101113;4255.5957184067465;4262.041040765865;4284.721493102938;4285.5071666758095;3806.5432148141845;3866.420036994417;3867.149227170018;3876.6123387661573;3885.825137868803;3133.4829753090485;3219.517072439153;3226.8225247611135;3235.563198968109;3242.8054316741072;1033.534909290822;1049.396596956753;1050.9316894401993;1056.2025670618634;1060.6287799270194;869.4915169735359;874.9081346458657;898.034612791252;899.7435730816686;1141.9942900285446;6274.560780745304;6291.842703932347;6303.558750887486;6310.6213627182515;6316.968415157987;407.5944435286909;425.6679789763989;428.2484240158564;429.7636300034968;430.50706940553516;4817.445993710698;4914.508549145128;4938.395021617988;4942.5304596063315;4978.77595508203;7236.674349654173;7496.100467943773;7585.886211706828;7595.126560445509;7807.726729564438;7264.564126152448;7581.12817026038;7628.313451789255;7645.4648174628355;7671.846563068707;6107.572469927062;6129.724162412702;6281.3404592518045;6303.086052522451;6312.968435157886;6004.789832355847;6053.8800321938825;6064.181335519648;6064.727087280995;6084.452399284086;6738.090357801634;6772.661366931732;6811.89782153278;6940.895886561605;7037.859242815012;6999.6850141742725;7208.135023797178;7214.098237720285;7232.891506627299;7242.203357630551;5827.125931110368;5877.147813566923;5883.764649413975;5887.558433117619;5893.941060589339;6252.218472690914;6288.496920246461;6382;6431.453326467303;6457.257415397102;5687.943120568907;5960.612560183574;6022.879542409215;6023.066424704178;6028.336882942785;5867.266591676041;5887.676177810262;5937.881242375215;5951.531016975981;5970.164177015135;6033.577649564489;6040.879182416239;6045.6070355426755;6091.086337049301;6117.327094019565;5220.895582088413;5236.738163091906;5263.526282634582;5277.973610131925;5327.547158491417;5347.679139251657;5349.251104845403;5349.4650534946195;5398.757055932414;5426.457354264542 05:51:55 INFO - 2015-11-17 05:51:55,612 DEBUG : BROWSER_OUTPUT: |4;prototype.html;273.53499051612266;274.2430890741553;280.79361669173153;282.88684028348456;284.3261470315353;5381;5539.307586551681;5649.661020338777;5677.3187217533905;5696.914546281809;5600.131979543167;5631.18347839563;5640.912862240966;5648.717564121798;5675.148727690848;4353.412289340946;4372.3878656988045;4373.475182978047;4374.956250437503;4425.712328698641;4369.4756629204385;4383.3863259143745;4383.912321753563;4384.430024096879;4409.096135292273;4324.6107850293465;4351.6518678505645;4361.171377438292;4381.43041404617;4401.889952751175;4009.7594144351287;4220.155968806235;4221.514525829538;4235.301175306071;4253.043065310311;3540.5751309842726;3584.13980644646;3589.4795254688183;3598.442241452579;3611.512445819807;5160.432352441228;5243.037683708692;5324.148136298212;5356.705381204032;5359.249705041298;4631.305304204363;4682.41469816273;4703.247480403119;4751.976240118777;4770.99809040102;5844.1818145459665;5848.795292164754;5875.676837773921;5886.028805247129;5886.411358864079;3843.9807800960816;3853.807309634535;3854.807259637035;3857.189990102082;3872.6514613684903;5954.702264886739;6093.055576385667;6158.291796443422;6197.628142311431;6204.9689751551405;3880.728349015542;3946.3685810270217;3957.089869330013;3970.205958808192;4004.5194576650406;4005.959940400617;4010.458588090629;4019.135885784512;4020.7587544747407;4054.1688953764406;4508.684392092588;4684.0866031123605;4688.5545873142;4713;4743.881402964885;5549.445055494499;5699.800506982318;5807.070868660994;5809.344336864058;5868.735906884201;1356.3353956561214;1382.4608402722947;1405.5642750747302;1410.5063227870164;1414.5190635184088;883.8939327280767;891.1712107739864;895.9731208063769;897.3314880414133;911.1981456318398;5535.169724541271;5609.214709940612;5639.464250896158;5647.6893770843;5694.9430505695245;6010.909836352458;6057.787977420858;6099.786507472306;6100.542459315569;6101.60339577926;5648.632838865543;5651.9152212716845;5653.773849045992;5664.943350566524;5673.687947162863;3176.6029246344206;3279.9180020499202;3291.308825146746;3292.1275861896615;3301.3892429900543;6136.386361363828;6143.815685529441;6182;6189.690515474208;6211.09939058834;6165.32181460039;6189.226346706661;6191.380861913863;6228.875422491525;6240.282367527701;5970.880582388328;6083.300420451616;6129.785457508966;6174.783882564088;6185.474234690102;6026.758929642765;6040.879182416239;6081.391860813883;6096.573239873166;6114.021756518936;5667.574931880208;5861.794837180678;5883.117532370179;5887.293524777054;5956.136360227656;6066.272047354346;6078.118672792332;6099.115628233792;6127.479164270909;6148.692565371624;3840.1743625120735;3927.1949250403027;3941.428492868575;3968.3253846846683;3983.0440694233753;5961.314448838439;6076.118962750288;6124.693765311627;6127.938720612737;6138.508919286357;5887.7056147191615;5954.07711804671;5970.761169553343;5987.401259873977;6007.30915944672;5930.229070220844;5950.702464876826;5977.641341519523;5979.4618484336615;6050.969745151246;5629.634073785191;5791;5795.072788354012;5799.072148456396;5835.708214589338;5934.43622855828;5946.405359464019;5985.162077309094;5990.820275391745;6067.12026756109;5856.472917437451;5872.970635146797;5894.764209431574;5913.113033045078;5919.85200369977 05:51:55 INFO - 2015-11-17 05:51:55,612 DEBUG : BROWSER_OUTPUT: |5;yui.html;569.7236840132538;609.4271384898195;629.25747617811;644.1752913474414;662.4898827902515;11573.13201509887;12189.08581856362;12318.568850090249;12329.445174967126;12349.567765128222;11069.114470842333;11258.887411125887;11412.31526108432;11436.71408214795;11580.65258042258;749.6139488163586;787.6337503061076;798.5328582779081;799.3804801279026;801.6552882260626;780.4224873593556;785.7603430953585;797.5932274539997;797.9920200798005;807.3379828540599;759.9696012159507;799.2447137455107;809.8542262392767;817.6116344736262;818.5907046476761;799.6321692021677;801.6032064128294;806.4637016384097;806.592670701295;810.6797814863155;595.5890435599466;598.7215944585745;602.7347966894596;602.7558838670302;605.4339192854651;10755.677329680044;10913.454327283684;10989.175811814146;10997.12023038155;11044.447777611087;8417.831643367159;8465.576721163918;8667.783305417352;9041.593128309241;9148.725538233864;7527.096748390173;7781;7844.882326765103;7949.403794715419;7951.840963180704;2383.4041489627593;2452.546278938384;2496.962545561818;2546.6434699142137;2801.495730768461;38989.220215595815;39061.41407878884;39373.60626393757;39676.20647587061;39734.40398394026;5695.1741997410145;5750.6262092963825;5800.477956983807;5860.3260625027815;5939.2575928009;10312.381257124596;10386.844197337046;10470.528826202839;10507.474626268657;10517.579296828195;5056.216286475602;5086.21163719624;5145;5241.109011468059;5277.472252774769;3110.4090222857585;3170.429322721886;3203.871845126169;3227.0480208338595;3245.123816569513;2303.838731288827;2322.605157123293;2338.9298321050396;2344.4021774447406;2353.223436266028;335.7498663495663;341.4161783350449;345.3024889722746;347.2551377295687;352.54345622419027;472.5794043301464;485.1412998991765;502.39712345185194;512.8205128205099;518.6913786297147;6695.330466953265;6960.269171736894;7128.322809333209;7182.317679820409;7538.736144234926;432.5782362196896;457.0656386001876;473.2215505493444;530.149110677365;545.0434487474457;3212.6947939945667;3460.3252365788935;3464.203233256315;3491.30173965208;3682.392405253157;49120;49688.503114968385;49821.501784982414;49980;50024.74987625112;41463.170736585096;42946.78526607347;43122.78438607787;44046.33930491045;45075.549244507136;40486.59513404828;40508;41362.79318603388;41482;42383.78808106001;7029.574796695132;7344.522606030591;7373;7495.475316727777;7580.279873412017;30502.38995220039;30715.078547643607;31007.0697879064;31104.533431998087;31713.5242971351;37025.814870925475;37181.81409093046;38589;40022.59920902755;40648.79675601603;8920.598573064099;9299.86050209261;9497.19273861702;9530;9673.516324183904;8533.74398768038;8535.189157030072;8662;8911;10390.376577405379;9149.63401463934;9474.289428292768;9609.423434593667;9638.807223855343;9686.370385924893;9207.217386522221;9224.16982471554;9229.353945224038;9246.167844893991;9981;8758.430702004349;9330.720078397659;9333.579988900652;9379.296552758708;9770.120689137728;6999.720011199495;7122.6438678066925;7237.167725711611;7492.625368731433;7703.845923081395;7344;7607.201243869314;7935.761927142195;8029.116797152192;8071.677132914618 05:51:55 INFO - 2015-11-17 05:51:55,613 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:51:55 INFO - 2015-11-17 05:51:55,614 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:51:55 INFO - 2015-11-17 05:51:55,614 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,292 05:51:55 INFO - 2015-11-17 05:51:55,614 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:51:55 INFO - 2015-11-17 05:51:55,614 DEBUG : BROWSER_OUTPUT: __startTimestamp1447768315599__endTimestamp 05:51:55 INFO - 2015-11-17 05:51:55,615 DEBUG : BROWSER_OUTPUT: 05:51:55 INFO - 2015-11-17 05:51:55,615 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:51:55 INFO - 2015-11-17 05:51:55,615 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:51:55 INFO - 2015-11-17 05:51:55,615 DEBUG : BROWSER_OUTPUT: 05:51:55 INFO - 2015-11-17 05:51:55,615 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4601.69 Median:4725.46 stddev:478.96 (10.1%) stddev-sans-first:455.97 05:51:55 INFO - 2015-11-17 05:51:55,615 DEBUG : BROWSER_OUTPUT: Values: 2675.5 2700.7 2735.6 2749.1 2757.7 4545.3 4648.7 4664.8 4679.8 4732.9 4475.1 4555.1 4644.0 4671.3 4693.6 4333.2 4376.1 4398.2 4404.1 4526.8 4333.3 4406.9 4410.3 4416.1 4507.9 4172.6 4183.1 4362.8 4405.6 4450.8 4376.6 4387.5 4418.0 4427.7 4441.2 4393.0 4414.6 4419.0 4435.3 4438.0 4285.6 4355.3 4481.7 4552.9 4621.2 4831.1 4874.6 4877.2 4934.5 4960.2 4930.6 4948.6 4968.2 4985.5 4999.5 4457.7 4491.8 4528.6 4541.9 4622.0 4809.7 4897.8 5015.9 5026.9 5077.8 4602.3 4735.6 4769.2 4808.4 4845.2 4749.2 4889.6 4925.3 4965.9 4968.0 4766.5 4919.6 4927.5 4935.0 4942.8 4701.7 4841.7 4869.6 4930.3 4954.0 3764.3 3769.2 3831.0 3843.2 3874.1 3476.9 3502.2 3520.8 3529.1 3542.6 4450.1 4569.2 4714.9 4740.6 4824.6 4938.1 4975.3 4984.8 5014.4 5028.0 4716.8 4720.7 4721.5 4725.0 4727.6 4196.2 4307.2 4315.8 4352.3 4399.1 4953.5 5073.0 5073.3 5095.8 5152.1 4918.4 4947.7 5002.5 5006.2 5033.5 4926.8 4971.4 5030.3 5037.2 5119.2 4869.7 4896.0 4926.2 4941.2 4987.9 4791.5 4992.8 5015.9 5022.0 5033.1 4428.5 4563.9 4710.5 4769.5 4770.7 4783.7 4814.1 4833.5 4853.9 4880.9 4489.5 4657.5 4684.1 4725.5 4788.7 4588.4 4802.6 4859.4 4882.7 4924.9 4663.4 4724.2 4755.4 4768.3 4770.5 05:51:55 INFO - 2015-11-17 05:51:55,616 DEBUG : BROWSER_OUTPUT: 05:51:55 INFO - 2015-11-17 05:51:55,616 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:40620.65 Median:35817.73 stddev:65528.84 (183.0%) stddev-sans-first:65643.26 05:51:55 INFO - 2015-11-17 05:51:55,617 DEBUG : BROWSER_OUTPUT: Values: 452.3 484.4 485.6 489.2 508.6 26743.9 31614.4 31760.2 31835.5 31887.0 35704.8 35822.0 35977.0 36006.3 36173.0 8059.5 8077.5 8180.9 8184.3 8255.6 7819.9 7966.1 8044.3 8085.4 8145.0 8003.4 8112.8 8162.6 8179.0 8198.2 7983.2 8086.8 8126.7 8135.5 8150.3 7894.1 7955.1 8007.0 8059.0 8076.9 33182.2 33769.7 33880.2 34478.8 34643.8 2625.3 2642.8 2653.5 2689.3 2947.8 23435.4 24719.6 24934.1 25591.1 25815.4 2009.7 2064.7 2066.3 2066.8 2137.1 227536.0 228078.0 228112.0 230330.0 233580.0 46436.3 48841.8 50309.5 50764.2 51031.2 48839.8 49159.5 49194.3 49254.3 49661.0 11981.9 12134.8 12159.4 12202.6 12206.5 8752.6 8818.0 8843.2 8852.3 8987.5 17478.5 17688.4 17747.6 17758.6 17915.0 7344.2 7653.7 7680.7 7703.1 7715.4 810.4 851.3 853.0 873.7 962.2 24418.5 24444.4 24490.9 24540.6 24560.1 855.5 896.3 917.2 942.9 966.1 12509.7 12636.9 12665.6 12736.3 12841.1 271234.0 278290.0 278354.0 282564.0 282750.0 45661.5 46195.5 47023.3 47086.8 47673.0 1160.2 1176.9 1180.5 1185.5 1186.2 23378.4 26585.0 27135.6 27561.0 27754.7 44163.0 44210.0 44225.6 44736.8 44813.0 238147.0 242728.0 243756.0 244354.0 247426.0 35955.0 38191.2 39328.6 39415.0 40217.4 35813.5 36312.0 36554.8 37463.4 37547.0 32543.3 33259.8 33340.8 34292.5 34838.3 26526.3 30378.8 30547.4 33516.2 36539.0 36224.6 36415.0 36963.1 37458.6 37594.0 31500.7 32172.8 33069.3 34216.4 34592.0 25910.7 26234.0 26357.2 26404.6 26557.2 05:51:55 INFO - 2015-11-17 05:51:55,617 DEBUG : BROWSER_OUTPUT: 05:51:55 INFO - 2015-11-17 05:51:55,619 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:23859.90 Median:4456.30 stddev:81535.60 (1829.7%) stddev-sans-first:81745.12 05:51:55 INFO - 2015-11-17 05:51:55,619 DEBUG : BROWSER_OUTPUT: Values: 288.3 289.1 290.8 296.1 297.2 12627.2 13070.0 15224.5 15246.9 15793.8 16156.9 16499.9 16549.2 16555.3 16649.7 4418.5 4708.0 4734.3 4737.9 4750.7 3919.5 4026.2 4036.0 4037.0 4701.4 4011.6 4052.4 4057.4 4059.7 4110.0 3962.1 4034.6 4132.9 4159.1 4170.1 3477.4 3477.6 3515.3 3536.8 3542.2 11006.8 11127.2 11396.8 11645.5 11647.9 1613.6 1654.6 1662.9 1690.9 1799.9 7851.1 8043.1 8242.8 8378.0 8409.7 1265.1 1302.3 1310.4 1354.5 1367.4 49352.0 51745.5 51766.7 51841.2 52705.0 5476.8 5583.0 5641.9 5650.9 5689.4 6419.7 6510.7 6515.3 6517.6 6527.5 4363.3 4399.7 4494.1 4494.9 4497.5 4522.1 4605.6 4608.3 4627.1 4632.8 2490.4 2515.5 2526.5 2540.1 2568.2 869.4 896.8 914.1 939.8 943.5 346.2 361.8 366.2 372.5 386.1 9729.5 10258.9 10290.3 10302.2 10402.7 391.8 394.2 401.3 404.3 423.0 5446.5 5462.3 5486.4 5545.4 5589.3 474821.0 489616.0 498964.0 509653.0 517269.0 59640.0 60764.4 61101.7 61169.4 62091.7 426.7 429.6 432.7 433.9 439.5 9209.9 9570.6 9608.1 9631.2 9637.8 27730.4 28713.1 29154.7 29440.6 29563.4 36817.6 37303.8 37633.6 37647.4 37769.8 5354.4 5375.5 5477.7 5481.3 5488.5 10001.7 10270.8 10334.6 10334.7 10351.4 8634.4 8895.2 8976.8 9074.3 9089.0 8459.8 8714.1 8756.9 8766.6 9019.8 9009.5 9025.2 9067.5 9213.7 9255.0 5317.5 5404.2 5464.4 5464.8 5479.0 8705.6 8924.1 9007.1 9023.9 9150.8 05:51:55 INFO - 2015-11-17 05:51:55,619 DEBUG : BROWSER_OUTPUT: 05:51:55 INFO - 2015-11-17 05:51:55,620 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4582.73 Median:5885.66 stddev:2347.79 (39.9%) stddev-sans-first:2340.83 05:51:55 INFO - 2015-11-17 05:51:55,620 DEBUG : BROWSER_OUTPUT: Values: 1226.6 1263.9 1375.1 1480.7 1516.6 6084.6 6120.4 6442.0 6842.0 6856.8 6376.5 6571.5 6689.4 6693.3 6697.7 1867.9 1907.3 1919.7 1920.8 1924.9 1943.2 1974.9 1986.5 2009.0 2016.0 1903.8 1933.7 1945.2 1954.7 1959.4 1836.8 1881.0 1909.5 1911.1 1913.6 1907.8 1915.9 1917.5 1919.9 1920.6 6566.8 6585.3 6599.9 6609.5 6640.0 3930.1 4037.4 4074.2 4079.8 4083.4 2116.1 2177.8 2430.4 2486.6 2501.4 739.1 749.4 768.6 770.9 784.5 8465.2 8506.7 8511.1 8519.0 8538.5 3707.6 3770.3 3906.0 3920.7 3922.3 7520.3 7583.8 7615.5 7622.9 7624.2 4230.5 4255.6 4262.0 4284.7 4285.5 3806.5 3866.4 3867.1 3876.6 3885.8 3133.5 3219.5 3226.8 3235.6 3242.8 1033.5 1049.4 1050.9 1056.2 1060.6 869.5 874.9 898.0 899.7 1142.0 6274.6 6291.8 6303.6 6310.6 6317.0 407.6 425.7 428.2 429.8 430.5 4817.4 4914.5 4938.4 4942.5 4978.8 7236.7 7496.1 7585.9 7595.1 7807.7 7264.6 7581.1 7628.3 7645.5 7671.8 6107.6 6129.7 6281.3 6303.1 6313.0 6004.8 6053.9 6064.2 6064.7 6084.5 6738.1 6772.7 6811.9 6940.9 7037.9 6999.7 7208.1 7214.1 7232.9 7242.2 5827.1 5877.1 5883.8 5887.6 5893.9 6252.2 6288.5 6382.0 6431.5 6457.3 5687.9 5960.6 6022.9 6023.1 6028.3 5867.3 5887.7 5937.9 5951.5 5970.2 6033.6 6040.9 6045.6 6091.1 6117.3 5220.9 5236.7 5263.5 5278.0 5327.5 5347.7 5349.3 5349.5 5398.8 5426.5 05:51:55 INFO - 2015-11-17 05:51:55,620 DEBUG : BROWSER_OUTPUT: 05:51:55 INFO - 2015-11-17 05:51:55,621 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4879.80 Median:5659.36 stddev:1505.99 (26.6%) stddev-sans-first:1469.99 05:51:55 INFO - 2015-11-17 05:51:55,622 DEBUG : BROWSER_OUTPUT: Values: 273.5 274.2 280.8 282.9 284.3 5381.0 5539.3 5649.7 5677.3 5696.9 5600.1 5631.2 5640.9 5648.7 5675.1 4353.4 4372.4 4373.5 4375.0 4425.7 4369.5 4383.4 4383.9 4384.4 4409.1 4324.6 4351.7 4361.2 4381.4 4401.9 4009.8 4220.2 4221.5 4235.3 4253.0 3540.6 3584.1 3589.5 3598.4 3611.5 5160.4 5243.0 5324.1 5356.7 5359.2 4631.3 4682.4 4703.2 4752.0 4771.0 5844.2 5848.8 5875.7 5886.0 5886.4 3844.0 3853.8 3854.8 3857.2 3872.7 5954.7 6093.1 6158.3 6197.6 6205.0 3880.7 3946.4 3957.1 3970.2 4004.5 4006.0 4010.5 4019.1 4020.8 4054.2 4508.7 4684.1 4688.6 4713.0 4743.9 5549.4 5699.8 5807.1 5809.3 5868.7 1356.3 1382.5 1405.6 1410.5 1414.5 883.9 891.2 896.0 897.3 911.2 5535.2 5609.2 5639.5 5647.7 5694.9 6010.9 6057.8 6099.8 6100.5 6101.6 5648.6 5651.9 5653.8 5664.9 5673.7 3176.6 3279.9 3291.3 3292.1 3301.4 6136.4 6143.8 6182.0 6189.7 6211.1 6165.3 6189.2 6191.4 6228.9 6240.3 5970.9 6083.3 6129.8 6174.8 6185.5 6026.8 6040.9 6081.4 6096.6 6114.0 5667.6 5861.8 5883.1 5887.3 5956.1 6066.3 6078.1 6099.1 6127.5 6148.7 3840.2 3927.2 3941.4 3968.3 3983.0 5961.3 6076.1 6124.7 6127.9 6138.5 5887.7 5954.1 5970.8 5987.4 6007.3 5930.2 5950.7 5977.6 5979.5 6051.0 5629.6 5791.0 5795.1 5799.1 5835.7 5934.4 5946.4 5985.2 5990.8 6067.1 5856.5 5873.0 5894.8 5913.1 5919.9 05:51:55 INFO - 2015-11-17 05:51:55,622 DEBUG : BROWSER_OUTPUT: 05:51:55 INFO - 2015-11-17 05:51:55,622 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:11367.12 Median:557.38 stddev:13790.59 (2474.2%) stddev-sans-first:13805.44 05:51:55 INFO - 2015-11-17 05:51:55,623 DEBUG : BROWSER_OUTPUT: Values: 569.7 609.4 629.3 644.2 662.5 11573.1 12189.1 12318.6 12329.4 12349.6 11069.1 11258.9 11412.3 11436.7 11580.7 749.6 787.6 798.5 799.4 801.7 780.4 785.8 797.6 798.0 807.3 760.0 799.2 809.9 817.6 818.6 799.6 801.6 806.5 806.6 810.7 595.6 598.7 602.7 602.8 605.4 10755.7 10913.5 10989.2 10997.1 11044.4 8417.8 8465.6 8667.8 9041.6 9148.7 7527.1 7781.0 7844.9 7949.4 7951.8 2383.4 2452.5 2497.0 2546.6 2801.5 38989.2 39061.4 39373.6 39676.2 39734.4 5695.2 5750.6 5800.5 5860.3 5939.3 10312.4 10386.8 10470.5 10507.5 10517.6 5056.2 5086.2 5145.0 5241.1 5277.5 3110.4 3170.4 3203.9 3227.0 3245.1 2303.8 2322.6 2338.9 2344.4 2353.2 335.7 341.4 345.3 347.3 352.5 472.6 485.1 502.4 512.8 518.7 6695.3 6960.3 7128.3 7182.3 7538.7 432.6 457.1 473.2 530.1 545.0 3212.7 3460.3 3464.2 3491.3 3682.4 49120.0 49688.5 49821.5 49980.0 50024.7 41463.2 42946.8 43122.8 44046.3 45075.5 40486.6 40508.0 41362.8 41482.0 42383.8 7029.6 7344.5 7373.0 7495.5 7580.3 30502.4 30715.1 31007.1 31104.5 31713.5 37025.8 37181.8 38589.0 40022.6 40648.8 8920.6 9299.9 9497.2 9530.0 9673.5 8533.7 8535.2 8662.0 8911.0 10390.4 9149.6 9474.3 9609.4 9638.8 9686.4 9207.2 9224.2 9229.4 9246.2 9981.0 8758.4 9330.7 9333.6 9379.3 9770.1 6999.7 7122.6 7237.2 7492.6 7703.8 7344.0 7607.2 7935.8 8029.1 8071.7 05:51:55 INFO - 2015-11-17 05:51:55,624 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:51:55 INFO - 2015-11-17 05:51:55,624 DEBUG : BROWSER_OUTPUT: 05:51:56 INFO - 2015-11-17 05:51:56,261 INFO : Browser exited with error code: 0 05:51:56 INFO - 2015-11-17 05:51:56,293 INFO : Completed test dromaeo_css (00:18:32) 05:51:56 INFO - 2015-11-17 05:51:56,293 INFO : Starting test kraken 05:51:56 INFO - 2015-11-17 05:51:56,293 DEBUG : operating with platform_type : mac_ 05:51:56 INFO - 2015-11-17 05:51:56,293 INFO : Initialising browser for kraken test... 05:51:56 INFO - 2015-11-17 05:51:56,308 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmpH71cKb/profile http://localhost:49276/getInfo.html 05:51:59 INFO - 2015-11-17 05:51:59,477 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:51:59 INFO - 2015-11-17 05:51:59,477 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:51:59 INFO - 2015-11-17 05:51:59,477 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:51:59 INFO - 2015-11-17 05:51:59,477 DEBUG : BROWSER_OUTPUT: __metrics 05:52:00 INFO - 2015-11-17 05:52:00,191 INFO : Browser initialized. 05:52:00 INFO - 2015-11-17 05:52:00,191 INFO : Running cycle 1/1 for kraken test... 05:52:00 INFO - 2015-11-17 05:52:00,191 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmpH71cKb/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:52:12 INFO - 2015-11-17 05:52:12,363 DEBUG : BROWSER_OUTPUT: RSS: Main: 241987584 05:52:12 INFO - 2015-11-17 05:52:12,363 DEBUG : BROWSER_OUTPUT: 05:52:15 INFO - 2015-11-17 05:52:15,237 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection) 05:52:15 INFO - 2015-11-17 05:52:15,843 DEBUG : BROWSER_OUTPUT: RSS: Main: 259702784 05:52:15 INFO - 2015-11-17 05:52:15,843 DEBUG : BROWSER_OUTPUT: 05:52:18 INFO - 2015-11-17 05:52:18,826 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-dft) 05:52:19 INFO - 2015-11-17 05:52:19,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 267411456 05:52:19 INFO - 2015-11-17 05:52:19,424 DEBUG : BROWSER_OUTPUT: 05:52:22 INFO - 2015-11-17 05:52:22,683 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-fft) 05:52:23 INFO - 2015-11-17 05:52:23,257 DEBUG : BROWSER_OUTPUT: RSS: Main: 268316672 05:52:23 INFO - 2015-11-17 05:52:23,257 DEBUG : BROWSER_OUTPUT: 05:52:25 INFO - 2015-11-17 05:52:25,406 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator) 05:52:25 INFO - 2015-11-17 05:52:25,998 DEBUG : BROWSER_OUTPUT: RSS: Main: 268754944 05:52:25 INFO - 2015-11-17 05:52:25,998 DEBUG : BROWSER_OUTPUT: 05:52:28 INFO - 2015-11-17 05:52:28,365 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:52:28 INFO - 2015-11-17 05:52:28,937 DEBUG : BROWSER_OUTPUT: RSS: Main: 267902976 05:52:28 INFO - 2015-11-17 05:52:28,937 DEBUG : BROWSER_OUTPUT: 05:52:32 INFO - 2015-11-17 05:52:32,363 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom) 05:52:32 INFO - 2015-11-17 05:52:32,949 DEBUG : BROWSER_OUTPUT: RSS: Main: 268804096 05:52:32 INFO - 2015-11-17 05:52:32,949 DEBUG : BROWSER_OUTPUT: 05:52:36 INFO - 2015-11-17 05:52:36,488 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate) 05:52:37 INFO - 2015-11-17 05:52:37,076 DEBUG : BROWSER_OUTPUT: RSS: Main: 267411456 05:52:37 INFO - 2015-11-17 05:52:37,076 DEBUG : BROWSER_OUTPUT: 05:52:40 INFO - 2015-11-17 05:52:40,314 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial) 05:52:40 INFO - 2015-11-17 05:52:40,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 268038144 05:52:40 INFO - 2015-11-17 05:52:40,908 DEBUG : BROWSER_OUTPUT: 05:52:42 INFO - 2015-11-17 05:52:42,641 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:52:43 INFO - 2015-11-17 05:52:43,224 DEBUG : BROWSER_OUTPUT: RSS: Main: 267874304 05:52:43 INFO - 2015-11-17 05:52:43,224 DEBUG : BROWSER_OUTPUT: 05:52:45 INFO - 2015-11-17 05:52:45,226 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:52:45 INFO - 2015-11-17 05:52:45,869 DEBUG : BROWSER_OUTPUT: RSS: Main: 267804672 05:52:45 INFO - 2015-11-17 05:52:45,869 DEBUG : BROWSER_OUTPUT: 05:52:48 INFO - 2015-11-17 05:52:48,254 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:52:48 INFO - 2015-11-17 05:52:48,836 DEBUG : BROWSER_OUTPUT: RSS: Main: 267665408 05:52:48 INFO - 2015-11-17 05:52:48,836 DEBUG : BROWSER_OUTPUT: 05:52:51 INFO - 2015-11-17 05:52:51,758 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:52:52 INFO - 2015-11-17 05:52:52,352 DEBUG : BROWSER_OUTPUT: RSS: Main: 268034048 05:52:52 INFO - 2015-11-17 05:52:52,352 DEBUG : BROWSER_OUTPUT: 05:52:55 INFO - 2015-11-17 05:52:55,315 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:52:55 INFO - 2015-11-17 05:52:55,907 DEBUG : BROWSER_OUTPUT: RSS: Main: 267796480 05:52:55 INFO - 2015-11-17 05:52:55,907 DEBUG : BROWSER_OUTPUT: 05:52:57 INFO - 2015-11-17 05:52:57,797 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49276/tests/kraken/driver.html?testName=ai-astar) 05:52:58 INFO - 2015-11-17 05:52:58,058 DEBUG : BROWSER_OUTPUT: RSS: Main: 267706368 05:52:58 INFO - 2015-11-17 05:52:58,059 DEBUG : BROWSER_OUTPUT: 05:52:58 INFO - 2015-11-17 05:52:58,059 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:52:58 INFO - 2015-11-17 05:52:58,059 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:52:58 INFO - 2015-11-17 05:52:58,059 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:52:58 INFO - 2015-11-17 05:52:58,059 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:52:58 INFO - 2015-11-17 05:52:58,060 DEBUG : BROWSER_OUTPUT: |0;ai-astar;130;124;135;131;128;141;130;135;134;127 05:52:58 INFO - 2015-11-17 05:52:58,060 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;176;162;184;192;156;180;177;157;187;157 05:52:58 INFO - 2015-11-17 05:52:58,060 DEBUG : BROWSER_OUTPUT: |2;audio-dft;189;201;209;201;199;192;193;193;195;204 05:52:58 INFO - 2015-11-17 05:52:58,060 DEBUG : BROWSER_OUTPUT: |3;audio-fft;80;83;96;144;82;84;86;87;116;80 05:52:58 INFO - 2015-11-17 05:52:58,060 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;101;105;155;107;110;110;143;104;103;147 05:52:58 INFO - 2015-11-17 05:52:58,061 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;142;143;142;137;142;140;136;137;142;147 05:52:58 INFO - 2015-11-17 05:52:58,061 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;149;156;153;149;157;156;149;150;156;157 05:52:58 INFO - 2015-11-17 05:52:58,061 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;113;118;127;129;118;128;127;125;121;127 05:52:58 INFO - 2015-11-17 05:52:58,061 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;69;74;76;77;76;80;80;79;80;77 05:52:58 INFO - 2015-11-17 05:52:58,061 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;77;82;84;85;84;86;81;82;82;83 05:52:58 INFO - 2015-11-17 05:52:58,061 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;100;103;110;107;108;108;104;104;117;113 05:52:58 INFO - 2015-11-17 05:52:58,062 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;152;154;154;162;159;158;164;157;162;154 05:52:58 INFO - 2015-11-17 05:52:58,062 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;169;182;190;190;184;183;180;189;192;188 05:52:58 INFO - 2015-11-17 05:52:58,062 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;79;84;85;85;88;88;88;90;90;87 05:52:58 INFO - 2015-11-17 05:52:58,062 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:52:58 INFO - 2015-11-17 05:52:58,062 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:52:58 INFO - 2015-11-17 05:52:58,063 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,736 05:52:58 INFO - 2015-11-17 05:52:58,063 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:52:58 INFO - 2015-11-17 05:52:58,063 DEBUG : BROWSER_OUTPUT: __startTimestamp1447768378053__endTimestamp 05:52:58 INFO - 2015-11-17 05:52:58,063 DEBUG : BROWSER_OUTPUT: 05:52:58 INFO - 2015-11-17 05:52:58,063 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:52:58 INFO - 2015-11-17 05:52:58,063 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:52:58 INFO - 2015-11-17 05:52:58,063 DEBUG : BROWSER_OUTPUT: 05:52:58 INFO - 2015-11-17 05:52:58,064 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:131.50 Median:132.50 stddev:4.88 (3.7%) stddev-sans-first:5.15 05:52:58 INFO - 2015-11-17 05:52:58,064 DEBUG : BROWSER_OUTPUT: Values: 130.0 124.0 135.0 131.0 128.0 141.0 130.0 135.0 134.0 127.0 05:52:58 INFO - 2015-11-17 05:52:58,064 DEBUG : BROWSER_OUTPUT: 05:52:58 INFO - 2015-11-17 05:52:58,064 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:172.80 Median:178.50 stddev:13.64 (7.6%) stddev-sans-first:14.41 05:52:58 INFO - 2015-11-17 05:52:58,064 DEBUG : BROWSER_OUTPUT: Values: 176.0 162.0 184.0 192.0 156.0 180.0 177.0 157.0 187.0 157.0 05:52:58 INFO - 2015-11-17 05:52:58,064 DEBUG : BROWSER_OUTPUT: 05:52:58 INFO - 2015-11-17 05:52:58,064 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:197.60 Median:200.00 stddev:6.24 (3.1%) stddev-sans-first:5.79 05:52:58 INFO - 2015-11-17 05:52:58,064 DEBUG : BROWSER_OUTPUT: Values: 189.0 201.0 209.0 201.0 199.0 192.0 193.0 193.0 195.0 204.0 05:52:58 INFO - 2015-11-17 05:52:58,065 DEBUG : BROWSER_OUTPUT: 05:52:58 INFO - 2015-11-17 05:52:58,065 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:93.80 Median:83.50 stddev:20.70 (24.8%) stddev-sans-first:21.35 05:52:58 INFO - 2015-11-17 05:52:58,065 DEBUG : BROWSER_OUTPUT: Values: 80.0 83.0 96.0 144.0 82.0 84.0 86.0 87.0 116.0 80.0 05:52:58 INFO - 2015-11-17 05:52:58,065 DEBUG : BROWSER_OUTPUT: 05:52:58 INFO - 2015-11-17 05:52:58,065 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:118.50 Median:110.00 stddev:20.98 (19.1%) stddev-sans-first:21.27 05:52:58 INFO - 2015-11-17 05:52:58,065 DEBUG : BROWSER_OUTPUT: Values: 101.0 105.0 155.0 107.0 110.0 110.0 143.0 104.0 103.0 147.0 05:52:58 INFO - 2015-11-17 05:52:58,065 DEBUG : BROWSER_OUTPUT: 05:52:58 INFO - 2015-11-17 05:52:58,065 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:140.80 Median:142.00 stddev:3.36 (2.4%) stddev-sans-first:3.54 05:52:58 INFO - 2015-11-17 05:52:58,065 DEBUG : BROWSER_OUTPUT: Values: 142.0 143.0 142.0 137.0 142.0 140.0 136.0 137.0 142.0 147.0 05:52:58 INFO - 2015-11-17 05:52:58,065 DEBUG : BROWSER_OUTPUT: 05:52:58 INFO - 2015-11-17 05:52:58,065 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:153.20 Median:156.00 stddev:3.58 (2.3%) stddev-sans-first:3.46 05:52:58 INFO - 2015-11-17 05:52:58,065 DEBUG : BROWSER_OUTPUT: Values: 149.0 156.0 153.0 149.0 157.0 156.0 149.0 150.0 156.0 157.0 05:52:58 INFO - 2015-11-17 05:52:58,065 DEBUG : BROWSER_OUTPUT: 05:52:58 INFO - 2015-11-17 05:52:58,066 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:123.30 Median:127.00 stddev:5.44 (4.3%) stddev-sans-first:4.30 05:52:58 INFO - 2015-11-17 05:52:58,066 DEBUG : BROWSER_OUTPUT: Values: 113.0 118.0 127.0 129.0 118.0 128.0 127.0 125.0 121.0 127.0 05:52:58 INFO - 2015-11-17 05:52:58,066 DEBUG : BROWSER_OUTPUT: 05:52:58 INFO - 2015-11-17 05:52:58,066 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:76.80 Median:78.00 stddev:3.43 (4.4%) stddev-sans-first:2.18 05:52:58 INFO - 2015-11-17 05:52:58,066 DEBUG : BROWSER_OUTPUT: Values: 69.0 74.0 76.0 77.0 76.0 80.0 80.0 79.0 80.0 77.0 05:52:58 INFO - 2015-11-17 05:52:58,066 DEBUG : BROWSER_OUTPUT: 05:52:58 INFO - 2015-11-17 05:52:58,066 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:82.60 Median:83.50 stddev:2.50 (3.0%) stddev-sans-first:1.64 05:52:58 INFO - 2015-11-17 05:52:58,066 DEBUG : BROWSER_OUTPUT: Values: 77.0 82.0 84.0 85.0 84.0 86.0 81.0 82.0 82.0 83.0 05:52:58 INFO - 2015-11-17 05:52:58,066 DEBUG : BROWSER_OUTPUT: 05:52:58 INFO - 2015-11-17 05:52:58,066 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:107.40 Median:108.00 stddev:5.04 (4.7%) stddev-sans-first:4.58 05:52:58 INFO - 2015-11-17 05:52:58,066 DEBUG : BROWSER_OUTPUT: Values: 100.0 103.0 110.0 107.0 108.0 108.0 104.0 104.0 117.0 113.0 05:52:58 INFO - 2015-11-17 05:52:58,066 DEBUG : BROWSER_OUTPUT: 05:52:58 INFO - 2015-11-17 05:52:58,066 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:157.60 Median:158.50 stddev:4.12 (2.6%) stddev-sans-first:3.83 05:52:58 INFO - 2015-11-17 05:52:58,066 DEBUG : BROWSER_OUTPUT: Values: 152.0 154.0 154.0 162.0 159.0 158.0 164.0 157.0 162.0 154.0 05:52:58 INFO - 2015-11-17 05:52:58,067 DEBUG : BROWSER_OUTPUT: 05:52:58 INFO - 2015-11-17 05:52:58,067 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:184.70 Median:188.50 stddev:6.82 (3.6%) stddev-sans-first:4.25 05:52:58 INFO - 2015-11-17 05:52:58,067 DEBUG : BROWSER_OUTPUT: Values: 169.0 182.0 190.0 190.0 184.0 183.0 180.0 189.0 192.0 188.0 05:52:58 INFO - 2015-11-17 05:52:58,067 DEBUG : BROWSER_OUTPUT: 05:52:58 INFO - 2015-11-17 05:52:58,067 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:86.40 Median:88.00 stddev:3.31 (3.8%) stddev-sans-first:2.17 05:52:58 INFO - 2015-11-17 05:52:58,067 DEBUG : BROWSER_OUTPUT: Values: 79.0 84.0 85.0 85.0 88.0 88.0 88.0 90.0 90.0 87.0 05:52:58 INFO - 2015-11-17 05:52:58,067 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:52:58 INFO - 2015-11-17 05:52:58,067 DEBUG : BROWSER_OUTPUT: 05:52:58 INFO - 2015-11-17 05:52:58,785 INFO : Browser exited with error code: 0 05:52:58 INFO - 2015-11-17 05:52:58,838 INFO : Completed test kraken (00:01:02) 05:52:58 INFO - 2015-11-17 05:52:58,838 INFO : Starting test v8_7 05:52:58 INFO - 2015-11-17 05:52:58,838 DEBUG : operating with platform_type : mac_ 05:52:58 INFO - 2015-11-17 05:52:58,838 INFO : Initialising browser for v8_7 test... 05:52:58 INFO - 2015-11-17 05:52:58,852 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmpqiY8r7/profile http://localhost:49276/getInfo.html 05:53:01 INFO - 2015-11-17 05:53:01,948 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:53:01 INFO - 2015-11-17 05:53:01,948 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:53:01 INFO - 2015-11-17 05:53:01,948 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 05:53:01 INFO - 2015-11-17 05:53:01,949 DEBUG : BROWSER_OUTPUT: __metrics 05:53:02 INFO - 2015-11-17 05:53:02,636 INFO : Browser initialized. 05:53:02 INFO - 2015-11-17 05:53:02,637 INFO : Running cycle 1/1 for v8_7 test... 05:53:02 INFO - 2015-11-17 05:53:02,637 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/T/tmpqiY8r7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:53:14 INFO - 2015-11-17 05:53:14,810 DEBUG : BROWSER_OUTPUT: RSS: Main: 242212864 05:53:14 INFO - 2015-11-17 05:53:14,810 DEBUG : BROWSER_OUTPUT: 05:53:37 INFO - 2015-11-17 05:53:37,401 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49276/tests/v8_7/run.html (next: http://localhost:49276/tests/v8_7/run.html) 05:53:37 INFO - 2015-11-17 05:53:37,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 262074368 05:53:37 INFO - 2015-11-17 05:53:37,663 DEBUG : BROWSER_OUTPUT: 05:53:37 INFO - 2015-11-17 05:53:37,663 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:53:37 INFO - 2015-11-17 05:53:37,663 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:53:37 INFO - 2015-11-17 05:53:37,664 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:53:37 INFO - 2015-11-17 05:53:37,664 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:53:37 INFO - 2015-11-17 05:53:37,664 DEBUG : BROWSER_OUTPUT: |0;Richards;188.5014137606032 05:53:37 INFO - 2015-11-17 05:53:37,664 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;228.93772893772893 05:53:37 INFO - 2015-11-17 05:53:37,664 DEBUG : BROWSER_OUTPUT: |2;Encrypt;369.4126339120798 05:53:37 INFO - 2015-11-17 05:53:37,664 DEBUG : BROWSER_OUTPUT: |3;Decrypt;6496.774193548387 05:53:37 INFO - 2015-11-17 05:53:37,664 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1305.4830287206266 05:53:37 INFO - 2015-11-17 05:53:37,665 DEBUG : BROWSER_OUTPUT: |5;Earley;1023.5414534288639 05:53:37 INFO - 2015-11-17 05:53:37,665 DEBUG : BROWSER_OUTPUT: |6;Boyer;15164.179104477613 05:53:37 INFO - 2015-11-17 05:53:37,665 DEBUG : BROWSER_OUTPUT: |7;RegExp;33850 05:53:37 INFO - 2015-11-17 05:53:37,665 DEBUG : BROWSER_OUTPUT: |8;Splay;813.6696501220505 05:53:37 INFO - 2015-11-17 05:53:37,665 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;6555.555555555556 05:53:37 INFO - 2015-11-17 05:53:37,665 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:53:37 INFO - 2015-11-17 05:53:37,666 DEBUG : BROWSER_OUTPUT: __startTimestamp1447768417661__endTimestamp 05:53:37 INFO - 2015-11-17 05:53:37,666 DEBUG : BROWSER_OUTPUT: 05:53:37 INFO - 2015-11-17 05:53:37,666 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:53:37 INFO - 2015-11-17 05:53:37,666 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:53:37 INFO - 2015-11-17 05:53:37,666 DEBUG : BROWSER_OUTPUT: 05:53:37 INFO - 2015-11-17 05:53:37,666 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:188.50 Median:188.50 stddev:0.00 (0.0%) 05:53:37 INFO - 2015-11-17 05:53:37,667 DEBUG : BROWSER_OUTPUT: Values: 188.5 05:53:37 INFO - 2015-11-17 05:53:37,667 DEBUG : BROWSER_OUTPUT: 05:53:37 INFO - 2015-11-17 05:53:37,667 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:228.94 Median:228.94 stddev:0.00 (0.0%) 05:53:37 INFO - 2015-11-17 05:53:37,667 DEBUG : BROWSER_OUTPUT: Values: 228.9 05:53:37 INFO - 2015-11-17 05:53:37,667 DEBUG : BROWSER_OUTPUT: 05:53:37 INFO - 2015-11-17 05:53:37,668 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:369.41 Median:369.41 stddev:0.00 (0.0%) 05:53:37 INFO - 2015-11-17 05:53:37,668 DEBUG : BROWSER_OUTPUT: Values: 369.4 05:53:37 INFO - 2015-11-17 05:53:37,668 DEBUG : BROWSER_OUTPUT: 05:53:37 INFO - 2015-11-17 05:53:37,668 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:6496.77 Median:6496.77 stddev:0.00 (0.0%) 05:53:37 INFO - 2015-11-17 05:53:37,668 DEBUG : BROWSER_OUTPUT: Values: 6496.8 05:53:37 INFO - 2015-11-17 05:53:37,668 DEBUG : BROWSER_OUTPUT: 05:53:37 INFO - 2015-11-17 05:53:37,669 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1305.48 Median:1305.48 stddev:0.00 (0.0%) 05:53:37 INFO - 2015-11-17 05:53:37,669 DEBUG : BROWSER_OUTPUT: Values: 1305.5 05:53:37 INFO - 2015-11-17 05:53:37,669 DEBUG : BROWSER_OUTPUT: 05:53:37 INFO - 2015-11-17 05:53:37,669 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:1023.54 Median:1023.54 stddev:0.00 (0.0%) 05:53:37 INFO - 2015-11-17 05:53:37,669 DEBUG : BROWSER_OUTPUT: Values: 1023.5 05:53:37 INFO - 2015-11-17 05:53:37,669 DEBUG : BROWSER_OUTPUT: 05:53:37 INFO - 2015-11-17 05:53:37,669 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15164.18 Median:15164.18 stddev:0.00 (0.0%) 05:53:37 INFO - 2015-11-17 05:53:37,671 DEBUG : BROWSER_OUTPUT: Values: 15164.2 05:53:37 INFO - 2015-11-17 05:53:37,671 DEBUG : BROWSER_OUTPUT: 05:53:37 INFO - 2015-11-17 05:53:37,671 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:33850.00 Median:33850.00 stddev:0.00 (0.0%) 05:53:37 INFO - 2015-11-17 05:53:37,671 DEBUG : BROWSER_OUTPUT: Values: 33850.0 05:53:37 INFO - 2015-11-17 05:53:37,671 DEBUG : BROWSER_OUTPUT: 05:53:37 INFO - 2015-11-17 05:53:37,671 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:813.67 Median:813.67 stddev:0.00 (0.0%) 05:53:37 INFO - 2015-11-17 05:53:37,672 DEBUG : BROWSER_OUTPUT: Values: 813.7 05:53:37 INFO - 2015-11-17 05:53:37,672 DEBUG : BROWSER_OUTPUT: 05:53:37 INFO - 2015-11-17 05:53:37,672 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:6555.56 Median:6555.56 stddev:0.00 (0.0%) 05:53:37 INFO - 2015-11-17 05:53:37,672 DEBUG : BROWSER_OUTPUT: Values: 6555.6 05:53:37 INFO - 2015-11-17 05:53:37,672 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:53:37 INFO - 2015-11-17 05:53:37,672 DEBUG : BROWSER_OUTPUT: 05:53:38 INFO - 2015-11-17 05:53:38,377 INFO : Browser exited with error code: 0 05:53:38 INFO - 2015-11-17 05:53:38,401 INFO : Completed test v8_7 (00:00:39) 05:53:38 INFO - 2015-11-17 05:53:38,618 INFO : Completed test suite (00:20:14) 05:53:38 INFO - 2015-11-17 05:53:38,618 DEBUG : Working with test: dromaeo_css 05:53:38 INFO - 2015-11-17 05:53:38,618 DEBUG : Generating results file: dromaeo_css 05:53:38 INFO - 2015-11-17 05:53:38,619 DEBUG : Working with test: kraken 05:53:38 INFO - 2015-11-17 05:53:38,619 DEBUG : Generating results file: kraken 05:53:38 INFO - 2015-11-17 05:53:38,620 INFO : javascript benchmark 05:53:38 INFO - 2015-11-17 05:53:38,620 DEBUG : Working with test: v8_7 05:53:38 INFO - 2015-11-17 05:53:38,620 DEBUG : Generating results file: v8_7 05:53:38 INFO - 2015-11-17 05:53:38,620 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:53:38 INFO - 2015-11-17 05:53:38,677 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,57]] 05:53:38 INFO - 2015-11-17 05:53:38,677 DEBUG : process_Request line: dromaeo_css 5729.20 graph.html#tests=[[72,1,57]] 05:53:38 INFO - 2015-11-17 05:53:38,677 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:53:38 INFO - 2015-11-17 05:53:38,708 DEBUG : process_Request line: kraken 1827.00 graph.html#tests=[[232,1,57]] 05:53:38 INFO - 2015-11-17 05:53:38,708 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:53:38 INFO - 2015-11-17 05:53:38,737 DEBUG : process_Request line: v8_7 16676.13 graph.html#tests=[[230,1,57]] 05:53:38 INFO - 2015-11-17 05:53:38,738 INFO : javascript benchmark 05:53:38 INFO - 2015-11-17 05:53:38,740 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [288.3267570223528, 289.095132236101, 290.8225982150889, 296.1308559378225, 297.23610321473814, 12627.179233349849, 13070.0, 15224.543263702093, 15246.92376538117, 15793.76309355359, 16156.919215403936, 16499.91750041248, 16549.172541372915, 16555.337786488526, 16649.66700665986, 4418.536053714354, 4707.952920470802, 4734.337192793012, 4737.881552961169, 4750.738709370983, 3919.529656441231, 4026.174634199982, 4036.031352475399, 4037.0, 4701.412323459567, 4011.5988401159943, 4052.3718823582244, 4057.371107478331, 4059.7158198926086, 4109.97945010276, 3962.0689138052535, 4034.5965403459713, 4132.855350062763, 4159.10579225468, 4170.061736109366, 3477.3914564951288, 3477.5826900771817, 3515.3145136698354, 3536.840842162109, 3542.220711443478, 11006.834897476545, 11127.165462590337, 11396.772064558663, 11645.534178632844, 11647.941760291229, 1613.6207991122078, 1654.619437529375, 1662.908540030298, 1690.923908424124, 1799.874008819383, 7851.097123830776, 8043.11525732169, 8242.752717418487, 8377.95811020947, 8409.747707568722, 1265.1080987903506, 1302.316283950924, 1310.4168644953, 1354.539456584766, 1367.3778430813957, 49352.0, 51745.48254517444, 51766.74116629393, 51841.22238166393, 52705.0, 5476.835694929158, 5583.0, 5641.9435805641415, 5650.886982260414, 5689.43105689436, 6419.711112999927, 6510.739570417225, 6515.283318834924, 6517.608943463408, 6527.477801775846, 4363.345498175299, 4399.714018588781, 4494.056248187917, 4494.910101798011, 4497.527759585262, 4522.095580883836, 4605.631549476034, 4608.331791890158, 4627.1439783640135, 4632.791524381411, 2490.3525083478426, 2515.4969006198467, 2526.456811785475, 2540.0601777342504, 2568.242368501297, 869.426178722053, 896.8116695493889, 914.1407077347272, 939.8214339275515, 943.5470973932413, 346.1906627716066, 361.84621535847685, 366.1596635720974, 372.5138694004296, 386.0503162220968, 9729.464879431558, 10258.897411025795, 10290.279680422298, 10302.227332950059, 10402.739931501621, 391.76102577427747, 394.1565050791309, 401.27369461275185, 404.26222144586245, 422.9788510574459, 5446.455354464601, 5462.317210348707, 5486.423925487846, 5545.445455454503, 5589.273394458694, 474821.0, 489616.0, 498964.0, 509653.0, 517269.0, 59640.0, 60764.39235607676, 61101.694491527254, 61169.38830611726, 62091.689541552005, 426.67146297351485, 429.56184691615005, 432.7100842435513, 433.9002029533225, 439.51653181500734, 9209.907900921173, 9570.569324380558, 9608.087231712976, 9631.181349585364, 9637.807243855224, 27730.44539109166, 28713.138605841857, 29154.70845291605, 29440.55839162457, 29563.40873182567, 36817.63182368142, 37303.81348093351, 37633.62366376301, 37647.43528847124, 37769.81115094407, 5354.3574771027725, 5375.462453754593, 5477.698726570077, 5481.314835645544, 5488.506034456918, 10001.699949001542, 10270.794584108127, 10334.638287659896, 10334.689959301233, 10351.378917264989, 8634.438761480484, 8895.154960278764, 8976.775580610538, 9074.31942604294, 9089.000209976764, 8459.788505287417, 8714.128587141235, 8756.912430875864, 8766.605502752263, 9019.819603608023, 9009.504477253813, 9025.232855207118, 9067.501287428991, 9213.723588292361, 9254.953725231331, 5317.548008419173, 5404.216388623706, 5464.371597266365, 5464.808731694372, 5479.0, 8705.608247628745, 8924.107589241024, 9007.099290071203, 9023.90976090257, 9150.771230719285], "dojo.html": [2675.4916565852486, 2700.74342937421, 2735.617013618095, 2749.120281509915, 2757.7380148885854, 4545.340925565795, 4648.674592778507, 4664.766761661912, 4679.812807487705, 4732.858014259569, 4475.1497215529025, 4555.111753208126, 4644.0, 4671.275952227402, 4693.6010439112715, 4333.198358303708, 4376.146651402978, 4398.230309695807, 4404.097160082176, 4526.75102869342, 4333.263345231318, 4406.86779396617, 4410.250257456224, 4416.138852923681, 4507.887302817423, 4172.561881002512, 4183.100633363811, 4362.760048197348, 4405.581469760367, 4450.799714012877, 4376.584224498668, 4387.451568553931, 4418.0, 4427.712198707074, 4441.222786012435, 4393.0, 4414.558544145591, 4418.977905110486, 4435.334699795057, 4438.023634800339, 4285.6142947134595, 4355.324924636687, 4481.663875209372, 4552.863414097583, 4621.168189725848, 4831.106245344622, 4874.610031197496, 4877.170880950247, 4934.5312195341385, 4960.156773348539, 4930.630202734774, 4948.604111671058, 4968.22992436173, 4985.52637499437, 4999.450060493343, 4457.665675074382, 4491.842785502525, 4528.592426681615, 4541.886452838706, 4622.006268652256, 4809.735464549483, 4897.7795999180125, 5015.899682006412, 5026.949730502648, 5077.822276220315, 4602.286645569942, 4735.573798358164, 4769.165396055746, 4808.35087263222, 4845.176320025604, 4749.1926372516755, 4889.559939605452, 4925.285833554186, 4965.90068198634, 4967.975160124249, 4766.523347665206, 4919.581835543947, 4927.508859476033, 4934.9753251233515, 4942.802287908516, 4701.717896926195, 4841.733704646208, 4869.586085182728, 4930.309756634074, 4954.0, 3764.322421964018, 3769.246150769857, 3830.961690383116, 3843.1929294847837, 3874.1089549403796, 3476.860925562949, 3502.176988407722, 3520.8063556504126, 3529.1177205698577, 3542.6280240574883, 4450.087732014929, 4569.246074397687, 4714.858554243378, 4740.620750340034, 4824.614030877521, 4938.135826230396, 4975.303457515951, 4984.800607975713, 5014.398272207285, 5028.044671512401, 4716.834910778106, 4720.716756994591, 4721.480637129913, 4725.0, 4727.550882666142, 4196.181744559782, 4307.160103779733, 4315.8489452869, 4352.260115780325, 4399.076193999232, 4953.455119936804, 5073.010762901273, 5073.340465739504, 5095.847124586268, 5152.149895267389, 4918.385201849769, 4947.6536642434685, 5002.474740152232, 5006.224035274393, 5033.521815427529, 4926.827561035347, 4971.353724015999, 5030.346055012825, 5037.219231019198, 5119.180931051014, 4869.683470574401, 4896.0, 4926.236433352836, 4941.160002799461, 4987.850364489072, 4791.47293797689, 4992.775325110306, 5015.874603134805, 5022.0, 5033.144365457954, 4428.468583769968, 4563.885902852455, 4710.528947105262, 4769.499202583679, 4770.666053376369, 4783.736894470838, 4814.109389762905, 4833.468318485035, 4853.854384368475, 4880.92678609814, 4489.461264648133, 4657.46439159501, 4684.110019096361, 4725.456572494069, 4788.688735232199, 4588.403507543998, 4802.639802014793, 4859.416869975626, 4882.707037577615, 4924.852254432372, 4663.417072865892, 4724.196886529367, 4755.358026666356, 4768.332433459249, 4770.522947705341], "mootools.html": [1226.5584389619735, 1263.949442022319, 1375.147408606664, 1480.7186634539437, 1516.6208447888027, 6084.604500707451, 6120.449159575637, 6442.001489769087, 6841.9657901710425, 6856.82857928552, 6376.52176086793, 6571.539992200548, 6689.431398331148, 6693.330666933304, 6697.732090716366, 1867.9252829886823, 1907.2561700936647, 1919.7024461208466, 1920.8271255586994, 1924.9326273580427, 1943.222710915638, 1974.8518861085404, 1986.4735845001087, 2008.9698654520193, 2016.022229218835, 1903.800100989397, 1933.719610656454, 1945.22191123551, 1954.7263383126374, 1959.3827944197533, 1836.825501577348, 1881.0406692586741, 1909.5226193451638, 1911.149538455388, 1913.6268427656612, 1907.8282954534159, 1915.9137838797149, 1917.4631103291101, 1919.9136038878144, 1920.5870737791442, 6566.835829104263, 6585.341465853377, 6599.868002639968, 6609.471242300652, 6639.966800165968, 3930.1157239621143, 4037.354023356278, 4074.246264441088, 4079.7552146870985, 4083.4283200351974, 2116.1429621003517, 2177.7931096545803, 2430.3802530354646, 2486.5648511510594, 2501.374656335916, 739.0613920321161, 749.4491548711693, 768.6195333309992, 770.930616244535, 784.4508843809356, 8465.195806398382, 8506.74479765608, 8511.148885111439, 8518.957405212996, 8538.487690738575, 3707.573629032696, 3770.2836461072857, 3906.0430194602504, 3920.666743326792, 3922.2547715933883, 7520.323170914535, 7583.810404739926, 7615.5430674159725, 7622.885656715153, 7624.161342252348, 4230.471191101113, 4255.5957184067465, 4262.041040765865, 4284.721493102938, 4285.5071666758095, 3806.5432148141845, 3866.420036994417, 3867.149227170018, 3876.6123387661573, 3885.825137868803, 3133.4829753090485, 3219.517072439153, 3226.8225247611135, 3235.563198968109, 3242.8054316741072, 1033.534909290822, 1049.396596956753, 1050.9316894401993, 1056.2025670618634, 1060.6287799270194, 869.4915169735359, 874.9081346458657, 898.034612791252, 899.7435730816686, 1141.9942900285446, 6274.560780745304, 6291.842703932347, 6303.558750887486, 6310.6213627182515, 6316.968415157987, 407.5944435286909, 425.6679789763989, 428.2484240158564, 429.7636300034968, 430.50706940553516, 4817.445993710698, 4914.508549145128, 4938.395021617988, 4942.5304596063315, 4978.77595508203, 7236.674349654173, 7496.100467943773, 7585.886211706828, 7595.126560445509, 7807.726729564438, 7264.564126152448, 7581.12817026038, 7628.313451789255, 7645.4648174628355, 7671.846563068707, 6107.572469927062, 6129.724162412702, 6281.3404592518045, 6303.086052522451, 6312.968435157886, 6004.789832355847, 6053.8800321938825, 6064.181335519648, 6064.727087280995, 6084.452399284086, 6738.090357801634, 6772.661366931732, 6811.89782153278, 6940.895886561605, 7037.859242815012, 6999.6850141742725, 7208.135023797178, 7214.098237720285, 7232.891506627299, 7242.203357630551, 5827.125931110368, 5877.147813566923, 5883.764649413975, 5887.558433117619, 5893.941060589339, 6252.218472690914, 6288.496920246461, 6382.0, 6431.453326467303, 6457.257415397102, 5687.943120568907, 5960.612560183574, 6022.879542409215, 6023.066424704178, 6028.336882942785, 5867.266591676041, 5887.676177810262, 5937.881242375215, 5951.531016975981, 5970.164177015135, 6033.577649564489, 6040.879182416239, 6045.6070355426755, 6091.086337049301, 6117.327094019565, 5220.895582088413, 5236.738163091906, 5263.526282634582, 5277.973610131925, 5327.547158491417, 5347.679139251657, 5349.251104845403, 5349.4650534946195, 5398.757055932414, 5426.457354264542], "ext.html": [452.3192595144307, 484.3775748163606, 485.5751217684526, 489.18306428264793, 508.5931254996003, 26743.866280668593, 31614.367712645733, 31760.20599485014, 31835.52246716301, 31887.0, 35704.82147589265, 35822.0, 35977.0, 36006.2798744025, 36173.0, 8059.516429014248, 8077.515349079044, 8180.918190818105, 8184.304334131606, 8255.587220638974, 7819.882701759449, 7966.123726390121, 8044.316233120192, 8085.4340196186295, 8145.022597288334, 8003.439759216857, 8112.756617301461, 8162.632681529316, 8179.0, 8198.180181981785, 7983.201679832028, 8086.757397278091, 8126.674933002673, 8135.511869287802, 8150.3479721622425, 7894.131645518988, 7955.085165206017, 8007.0, 8059.032916050053, 8076.8788468173025, 33182.17044573881, 33769.6623033769, 33880.15299617529, 34478.82760586181, 34643.82678086594, 2625.3174174714522, 2642.7885769138425, 2653.4693061387607, 2689.287338855205, 2947.7936544441895, 23435.4141146471, 24719.62920556193, 24934.127305544218, 25591.104311349012, 25815.35461613456, 2009.6784514477613, 2064.7315848939693, 2066.318115022039, 2066.762322332921, 2137.10241698487, 227536.0, 228078.0, 228112.0, 230329.9999999983, 233580.0, 46436.303455447516, 48841.755791220814, 50309.49690503048, 50764.23853642198, 51031.234531482056, 48839.75580122148, 49159.50840491549, 49194.26208606874, 49254.261186082236, 49661.0, 11981.940090299493, 12134.817977730341, 12159.392030398622, 12202.633920982385, 12206.450709718085, 8752.606132724042, 8817.955910220408, 8843.248323892412, 8852.336074794417, 8987.505687187137, 17478.475645730647, 17688.380906668204, 17747.556311092067, 17758.556036099202, 17915.014674193044, 7344.155422126417, 7653.6938522459595, 7680.692772289158, 7703.114141873644, 7715.421343399267, 810.3598157455662, 851.2679095977454, 853.0360692417529, 873.7073080518097, 962.1965658674944, 24418.51162976766, 24444.388890277885, 24490.877545612515, 24540.631890521658, 24560.140395086444, 855.461059532503, 896.3367108339912, 917.2066162769156, 942.948137852411, 966.1063516247443, 12509.687257818627, 12636.873631263754, 12665.620031399072, 12736.299503527394, 12841.101122921305, 271234.0, 278290.0, 278354.0, 282564.0, 282750.0, 45661.54338456573, 46195.53804461913, 47023.29465058027, 47086.76456617763, 47673.04653906902, 1160.2458402038574, 1176.864660564029, 1180.492388273051, 1185.5020891225706, 1186.2408058842348, 23378.415539611648, 26585.0, 27135.613119176363, 27561.0, 27754.722452775215, 44163.0, 44210.0, 44225.55774442343, 44736.77631611821, 44813.0, 238147.0, 242728.0, 243756.0, 244354.0, 247426.0, 35955.0, 38191.23617527689, 39328.606713932495, 39415.0, 40217.39673904835, 35813.46279805857, 36312.0, 36554.81722591476, 37463.43804842875, 37547.0, 32543.34913301768, 33259.83370083134, 33340.83329583336, 34292.48561271533, 34838.303233934676, 26526.336841579116, 30378.848105760215, 30547.389052219274, 33516.162095947795, 36539.0, 36224.637753622126, 36415.0, 36963.07592310106, 37458.62541374551, 37594.0, 31500.684993149775, 32172.83913580417, 33069.33861322808, 34216.38723499584, 34592.0, 25910.74089259083, 26234.0, 26357.20928372152, 26404.603930941437, 26557.203283901516], "prototype.html": [273.53499051612266, 274.2430890741553, 280.79361669173153, 282.88684028348456, 284.3261470315353, 5381.0, 5539.307586551681, 5649.661020338777, 5677.3187217533905, 5696.914546281809, 5600.131979543167, 5631.18347839563, 5640.912862240966, 5648.717564121798, 5675.148727690848, 4353.412289340946, 4372.3878656988045, 4373.475182978047, 4374.956250437503, 4425.712328698641, 4369.4756629204385, 4383.3863259143745, 4383.912321753563, 4384.430024096879, 4409.096135292273, 4324.6107850293465, 4351.6518678505645, 4361.171377438292, 4381.43041404617, 4401.889952751175, 4009.7594144351287, 4220.155968806235, 4221.514525829538, 4235.301175306071, 4253.043065310311, 3540.5751309842726, 3584.13980644646, 3589.4795254688183, 3598.442241452579, 3611.512445819807, 5160.432352441228, 5243.037683708692, 5324.148136298212, 5356.705381204032, 5359.249705041298, 4631.305304204363, 4682.41469816273, 4703.247480403119, 4751.976240118777, 4770.99809040102, 5844.1818145459665, 5848.795292164754, 5875.676837773921, 5886.028805247129, 5886.411358864079, 3843.9807800960816, 3853.807309634535, 3854.807259637035, 3857.189990102082, 3872.6514613684903, 5954.702264886739, 6093.055576385667, 6158.291796443422, 6197.628142311431, 6204.9689751551405, 3880.728349015542, 3946.3685810270217, 3957.089869330013, 3970.205958808192, 4004.5194576650406, 4005.959940400617, 4010.458588090629, 4019.135885784512, 4020.7587544747407, 4054.1688953764406, 4508.684392092588, 4684.0866031123605, 4688.5545873142, 4713.0, 4743.881402964885, 5549.445055494499, 5699.800506982318, 5807.070868660994, 5809.344336864058, 5868.735906884201, 1356.3353956561214, 1382.4608402722947, 1405.5642750747302, 1410.5063227870164, 1414.5190635184088, 883.8939327280767, 891.1712107739864, 895.9731208063769, 897.3314880414133, 911.1981456318398, 5535.169724541271, 5609.214709940612, 5639.464250896158, 5647.6893770843, 5694.9430505695245, 6010.909836352458, 6057.787977420858, 6099.786507472306, 6100.542459315569, 6101.60339577926, 5648.632838865543, 5651.9152212716845, 5653.773849045992, 5664.943350566524, 5673.687947162863, 3176.6029246344206, 3279.9180020499202, 3291.308825146746, 3292.1275861896615, 3301.3892429900543, 6136.386361363828, 6143.815685529441, 6182.0, 6189.690515474208, 6211.09939058834, 6165.32181460039, 6189.226346706661, 6191.380861913863, 6228.875422491525, 6240.282367527701, 5970.880582388328, 6083.300420451616, 6129.785457508966, 6174.783882564088, 6185.474234690102, 6026.758929642765, 6040.879182416239, 6081.391860813883, 6096.573239873166, 6114.021756518936, 5667.574931880208, 5861.794837180678, 5883.117532370179, 5887.293524777054, 5956.136360227656, 6066.272047354346, 6078.118672792332, 6099.115628233792, 6127.479164270909, 6148.692565371624, 3840.1743625120735, 3927.1949250403027, 3941.428492868575, 3968.3253846846683, 3983.0440694233753, 5961.314448838439, 6076.118962750288, 6124.693765311627, 6127.938720612737, 6138.508919286357, 5887.7056147191615, 5954.07711804671, 5970.761169553343, 5987.401259873977, 6007.30915944672, 5930.229070220844, 5950.702464876826, 5977.641341519523, 5979.4618484336615, 6050.969745151246, 5629.634073785191, 5791.0, 5795.072788354012, 5799.072148456396, 5835.708214589338, 5934.43622855828, 5946.405359464019, 5985.162077309094, 5990.820275391745, 6067.12026756109, 5856.472917437451, 5872.970635146797, 5894.764209431574, 5913.113033045078, 5919.85200369977], "yui.html": [569.7236840132538, 609.4271384898195, 629.25747617811, 644.1752913474414, 662.4898827902515, 11573.13201509887, 12189.08581856362, 12318.568850090249, 12329.445174967126, 12349.567765128222, 11069.114470842333, 11258.887411125887, 11412.31526108432, 11436.71408214795, 11580.65258042258, 749.6139488163586, 787.6337503061076, 798.5328582779081, 799.3804801279026, 801.6552882260626, 780.4224873593556, 785.7603430953585, 797.5932274539997, 797.9920200798005, 807.3379828540599, 759.9696012159507, 799.2447137455107, 809.8542262392767, 817.6116344736262, 818.5907046476761, 799.6321692021677, 801.6032064128294, 806.4637016384097, 806.592670701295, 810.6797814863155, 595.5890435599466, 598.7215944585745, 602.7347966894596, 602.7558838670302, 605.4339192854651, 10755.677329680044, 10913.454327283684, 10989.175811814146, 10997.12023038155, 11044.447777611087, 8417.831643367159, 8465.576721163918, 8667.783305417352, 9041.593128309241, 9148.725538233864, 7527.096748390173, 7781.0, 7844.882326765103, 7949.403794715419, 7951.840963180704, 2383.4041489627593, 2452.546278938384, 2496.962545561818, 2546.6434699142137, 2801.495730768461, 38989.220215595815, 39061.41407878884, 39373.60626393757, 39676.20647587061, 39734.40398394026, 5695.1741997410145, 5750.6262092963825, 5800.477956983807, 5860.3260625027815, 5939.2575928009, 10312.381257124596, 10386.844197337046, 10470.528826202839, 10507.474626268657, 10517.579296828195, 5056.216286475602, 5086.21163719624, 5145.0, 5241.109011468059, 5277.472252774769, 3110.4090222857585, 3170.429322721886, 3203.871845126169, 3227.0480208338595, 3245.123816569513, 2303.838731288827, 2322.605157123293, 2338.9298321050396, 2344.4021774447406, 2353.223436266028, 335.7498663495663, 341.4161783350449, 345.3024889722746, 347.2551377295687, 352.54345622419027, 472.5794043301464, 485.1412998991765, 502.39712345185194, 512.8205128205099, 518.6913786297147, 6695.330466953265, 6960.269171736894, 7128.322809333209, 7182.317679820409, 7538.736144234926, 432.5782362196896, 457.0656386001876, 473.2215505493444, 530.149110677365, 545.0434487474457, 3212.6947939945667, 3460.3252365788935, 3464.203233256315, 3491.30173965208, 3682.392405253157, 49120.0, 49688.503114968385, 49821.501784982414, 49980.0, 50024.74987625112, 41463.170736585096, 42946.78526607347, 43122.78438607787, 44046.33930491045, 45075.549244507136, 40486.59513404828, 40508.0, 41362.79318603388, 41482.0, 42383.78808106001, 7029.574796695132, 7344.522606030591, 7373.0, 7495.475316727777, 7580.279873412017, 30502.38995220039, 30715.078547643607, 31007.0697879064, 31104.533431998087, 31713.5242971351, 37025.814870925475, 37181.81409093046, 38589.0, 40022.59920902755, 40648.79675601603, 8920.598573064099, 9299.86050209261, 9497.19273861702, 9530.0, 9673.516324183904, 8533.74398768038, 8535.189157030072, 8662.0, 8911.0, 10390.376577405379, 9149.63401463934, 9474.289428292768, 9609.423434593667, 9638.807223855343, 9686.370385924893, 9207.217386522221, 9224.16982471554, 9229.353945224038, 9246.167844893991, 9981.0, 8758.430702004349, 9330.720078397659, 9333.579988900652, 9379.296552758708, 9770.120689137728, 6999.720011199495, 7122.6438678066925, 7237.167725711611, 7492.625368731433, 7703.845923081395, 7344.0, 7607.201243869314, 7935.761927142195, 8029.116797152192, 8071.677132914618]}, "summary": {"lowerIsBetter": false, "suite": 5729.203769090551, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 5805.193171066592, "unit": "ms", "value": 5805.193171066592}, "dojo.html": {"lowerIsBetter": false, "filtered": 4572.215836671468, "unit": "ms", "value": 4572.215836671468}, "mootools.html": {"lowerIsBetter": false, "filtered": 3706.3608936665323, "unit": "ms", "value": 3706.3608936665323}, "ext.html": {"lowerIsBetter": false, "filtered": 16231.53713530661, "unit": "ms", "value": 16231.53713530661}, "prototype.html": {"lowerIsBetter": false, "filtered": 4369.368785744539, "unit": "ms", "value": 4369.368785744539}, "yui.html": {"lowerIsBetter": false, "filtered": 5068.181732948133, "unit": "ms", "value": 5068.181732948133}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0034.e"}, "testrun": {"date": 1447767203, "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": "20151117032807", "branch": "Firefox", "revision": "f8b569906e4c257687664227f470e416872d5802"}}, {"talos_counters": {}, "results": {"audio-dft": [189.0, 201.0, 209.0, 201.0, 199.0, 192.0, 193.0, 193.0, 195.0, 204.0], "ai-astar": [130.0, 124.0, 135.0, 131.0, 128.0, 141.0, 130.0, 135.0, 134.0, 127.0], "imaging-gaussian-blur": [142.0, 143.0, 142.0, 137.0, 142.0, 140.0, 136.0, 137.0, 142.0, 147.0], "audio-beat-detection": [176.0, 162.0, 184.0, 192.0, 156.0, 180.0, 177.0, 157.0, 187.0, 157.0], "json-stringify-tinderbox": [77.0, 82.0, 84.0, 85.0, 84.0, 86.0, 81.0, 82.0, 82.0, 83.0], "stanford-crypto-pbkdf2": [169.0, 182.0, 190.0, 190.0, 184.0, 183.0, 180.0, 189.0, 192.0, 188.0], "json-parse-financial": [69.0, 74.0, 76.0, 77.0, 76.0, 80.0, 80.0, 79.0, 80.0, 77.0], "stanford-crypto-sha256-iterative": [79.0, 84.0, 85.0, 85.0, 88.0, 88.0, 88.0, 90.0, 90.0, 87.0], "audio-fft": [80.0, 83.0, 96.0, 144.0, 82.0, 84.0, 86.0, 87.0, 116.0, 80.0], "imaging-darkroom": [149.0, 156.0, 153.0, 149.0, 157.0, 156.0, 149.0, 150.0, 156.0, 157.0], "stanford-crypto-ccm": [152.0, 154.0, 154.0, 162.0, 159.0, 158.0, 164.0, 157.0, 162.0, 154.0], "audio-oscillator": [101.0, 105.0, 155.0, 107.0, 110.0, 110.0, 143.0, 104.0, 103.0, 147.0], "stanford-crypto-aes": [100.0, 103.0, 110.0, 107.0, 108.0, 108.0, 104.0, 104.0, 117.0, 113.0], "imaging-desaturate": [113.0, 118.0, 127.0, 129.0, 118.0, 128.0, 127.0, 125.0, 121.0, 127.0]}, "summary": {"lowerIsBetter": true, "suite": 1827.0, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 93.8, "unit": "ms", "value": 93.8}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 184.7, "unit": "ms", "value": 184.7}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 172.8, "unit": "ms", "value": 172.8}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 157.6, "unit": "ms", "value": 157.6}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 153.2, "unit": "ms", "value": 153.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 76.8, "unit": "ms", "value": 76.8}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 118.5, "unit": "ms", "value": 118.5}, "ai-astar": {"lowerIsBetter": true, "filtered": 131.5, "unit": "ms", "value": 131.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 197.6, "unit": "ms", "value": 197.6}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 86.4, "unit": "ms", "value": 86.4}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 82.6, "unit": "ms", "value": 82.6}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 140.8, "unit": "ms", "value": 140.8}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 107.4, "unit": "ms", "value": 107.4}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 123.3, "unit": "ms", "value": 123.3}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0034.e"}, "testrun": {"date": 1447767203, "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": "20151117032807", "branch": "Firefox", "revision": "f8b569906e4c257687664227f470e416872d5802"}}, {"talos_counters": {}, "results": {"DeltaBlue": [228.93772893772893], "Encrypt": [369.4126339120798], "NavierStokes": [6555.555555555556], "Decrypt": [6496.774193548387], "Splay": [813.6696501220505], "Richards": [188.5014137606032], "RegExp": [33850.0], "Earley": [1023.5414534288639], "Boyer": [15164.179104477613], "RayTrace": [1305.4830287206266]}, "summary": {"lowerIsBetter": false, "suite": 16676.128928256425, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 288.803424, "unit": "score", "value": 288.803424}, "Encrypt": {"lowerIsBetter": false, "filtered": 720.5519670000001, "unit": "score", "value": 720.5519670000001}, "NavierStokes": {"lowerIsBetter": false, "filtered": 226.372881355932, "unit": "score", "value": 226.372881355932}, "Decrypt": {"lowerIsBetter": false, "filtered": 40.9712562065541, "unit": "score", "value": 40.9712562065541}, "Splay": {"lowerIsBetter": false, "filtered": 100.15243899999999, "unit": "score", "value": 100.15243899999999}, "RegExp": {"lowerIsBetter": false, "filtered": 26.912407680945357, "unit": "score", "value": 26.912407680945357}, "Richards": {"lowerIsBetter": false, "filtered": 187.27711000000005, "unit": "score", "value": 187.27711000000005}, "Earley": {"lowerIsBetter": false, "filtered": 651.1343510000002, "unit": "score", "value": 651.1343510000002}, "Boyer": {"lowerIsBetter": false, "filtered": 43.94982381889767, "unit": "score", "value": 43.94982381889767}, "RayTrace": {"lowerIsBetter": false, "filtered": 566.8315740000002, "unit": "score", "value": 566.8315740000002}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0034.e"}, "testrun": {"date": 1447767203, "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": "20151117032807", "branch": "Firefox", "revision": "f8b569906e4c257687664227f470e416872d5802"}}] 05:53:38 INFO - RETURN: dromaeo_css: 5729.20 05:53:38 INFO - RETURN: kraken: 1827.00 05:53:38 INFO - RETURN: v8_7: 16676.13 05:53:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,57]]", "result": "16676.13"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,57]]", "result": "1827.00"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,57]]", "result": "5729.20"}}} 05:53:38 INFO - Return code: 0 05:53:38 INFO - # TBPL SUCCESS # 05:53:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:53:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:53:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:53:38 INFO - 2015-11-17 05:53:38.852 screenresolution[1666:10719] starting screenresolution argv=screenresolution get 05:53:38 INFO - 2015-11-17 05:53:38.855 screenresolution[1666:10719] Display 0: 1600x1200x32@60 05:53:38 INFO - 2015-11-17 05:53:38.861 screenresolution[1667:10722] starting screenresolution argv=screenresolution list 05:53:38 INFO - Available Modes on Display 0 05:53:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:53:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:53:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:53:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:53:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:53:39 INFO - Intel HD Graphics 3000: 05:53:39 INFO - Chipset Model: Intel HD Graphics 3000 05:53:39 INFO - Type: GPU 05:53:39 INFO - Bus: Built-In 05:53:39 INFO - VRAM (Total): 512 MB 05:53:39 INFO - VRAM (Dynamic, Max): 10 05:53:39 INFO - Vendor: Intel (0x8086) 05:53:39 INFO - Device ID: 0x0116 05:53:39 INFO - Revision ID: 0x0009 05:53:39 INFO - Displays: 05:53:39 INFO - Display: 05:53:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:53:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:53:39 INFO - Display Serial Number: 1600x1200 60 05:53:39 INFO - Main Display: Yes 05:53:39 INFO - Mirror: Off 05:53:39 INFO - Online: Yes 05:53:39 INFO - Rotation: Supported 05:53:39 INFO - Return code: 0 05:53:39 INFO - Running post-action listener: _resource_record_post_action 05:53:39 INFO - Running post-run listener: _resource_record_post_run 05:53:40 INFO - Total resource usage - Wall time: 1257s; CPU: 30.0%; Read bytes: 45499392; Write bytes: 693524480; Read time: 6527; Write time: 56317 05:53:40 INFO - install - Wall time: 41s; CPU: 30.0%; Read bytes: 335256064; Write bytes: 334395392; Read time: 35114; Write time: 4131 05:53:40 INFO - run-tests - Wall time: 1216s; CPU: 30.0%; Read bytes: 44516352; Write bytes: 348753920; Read time: 6206; Write time: 51431 05:53:40 INFO - Running post-run listener: _upload_blobber_files 05:53:40 INFO - Blob upload gear active. 05:53:40 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:53:40 INFO - Copying logs to upload dir... 05:53:40 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1316.327239 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 56 secs) (at 2015-11-17 05:53:40.296267) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 05:53:40.301680) ========= 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.8J8aS6cGgO/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.nInnzzQjiH/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010084 build_url: 'https://queue.taskcluster.net/v1/task/hQjDk-86TxurJrYTUPbQMQ/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-17 05:53:40.328181) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:53:40.328610) ========= 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.8J8aS6cGgO/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.nInnzzQjiH/Listeners TMPDIR=/var/folders/tl/2ct7hv6552d6h3hfz53l67k000000w/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.005273 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-17 05:53:40.378823) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 05:53:40.379243) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-17 05:53:40.379901) ========= ========= Total master_lag: 0.37 =========