builder: mozilla-central_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0023 starttime: 1447296033.7 results: success (0) buildid: 20151111164246 builduid: fc049c5baadb4cf2aa9759ec2970dc9a revision: e86bdbfed16469a76af03f0682e215ec33b2ee74 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:33.704879) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:33.705465) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:33.705900) ========= 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.iMXLQy1McM/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.UgTVGkwdgx/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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.006344 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:33.734125) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:33.734474) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:33.785575) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:33.786290) ========= 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.iMXLQy1McM/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.UgTVGkwdgx/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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.013482 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:33.837469) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:33.837899) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:33.838413) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:33.838773) ========= 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.iMXLQy1McM/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.UgTVGkwdgx/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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-11 18:40:33-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: `archiver_client.py' 0K .......... . 100% 1.26G=0s 2015-11-11 18:40:33 (1.26 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.127811 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:33.985620) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:33.985982) ========= 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.iMXLQy1McM/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.UgTVGkwdgx/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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.093878 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:34.096817) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-11 18:40:34.097389) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e86bdbfed16469a76af03f0682e215ec33b2ee74 --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 e86bdbfed16469a76af03f0682e215ec33b2ee74 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.iMXLQy1McM/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.UgTVGkwdgx/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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-11 18:40:34,194 truncating revision to first 12 chars 2015-11-11 18:40:34,194 Setting DEBUG logging. 2015-11-11 18:40:34,194 attempt 1/10 2015-11-11 18:40:34,194 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e86bdbfed164?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-11 18:40:35,554 unpacking tar archive at: mozilla-central-e86bdbfed164/testing/mozharness/ program finished with exit code 0 elapsedTime=1.648222 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2015-11-11 18:40:35.766124) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:35.766586) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:35.782188) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:35.782705) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-11 18:40:35.783293) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2015-11-11 18:40:35.783678) ========= /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.iMXLQy1McM/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.UgTVGkwdgx/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 18:40:36 INFO - MultiFileLogger online at 20151111 18:40:36 in /builds/slave/test 18:40:36 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 18:40:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 18:40:36 INFO - {'append_to_log': False, 18:40:36 INFO - 'base_work_dir': '/builds/slave/test', 18:40:36 INFO - 'blob_upload_branch': 'Firefox', 18:40:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 18:40:36 INFO - 'branch': 'Firefox', 18:40:36 INFO - 'buildbot_json_path': 'buildprops.json', 18:40:36 INFO - 'config_files': ('talos/mac_config.py',), 18:40:36 INFO - 'default_actions': ('clobber', 18:40:36 INFO - 'read-buildbot-config', 18:40:36 INFO - 'download-and-extract', 18:40:36 INFO - 'populate-webroot', 18:40:36 INFO - 'create-virtualenv', 18:40:36 INFO - 'install', 18:40:36 INFO - 'run-tests'), 18:40:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 18:40:36 INFO - 'download_minidump_stackwalk': True, 18:40:36 INFO - 'download_symbols': 'ondemand', 18:40:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 18:40:36 INFO - 'tooltool.py': '/tools/tooltool.py', 18:40:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 18:40:36 INFO - '/tools/misc-python/virtualenv.py')}, 18:40:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 18:40:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 18:40:36 INFO - 'installer_path': 'installer.exe', 18:40:36 INFO - 'log_level': 'info', 18:40:36 INFO - 'log_name': 'talos', 18:40:36 INFO - 'log_to_console': True, 18:40:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 18:40:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 18:40:36 INFO - 'opt_config_files': (), 18:40:36 INFO - 'pip_index': False, 18:40:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:40:36 INFO - 'cmd': ('bash', 18:40:36 INFO - '-c', 18:40:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:40:36 INFO - 'enabled': True, 18:40:36 INFO - 'halt_on_failure': False, 18:40:36 INFO - 'name': 'check_screen_resolution'},), 18:40:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 18:40:36 INFO - 'cmd': ('bash', 18:40:36 INFO - '-c', 18:40:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 18:40:36 INFO - 'enabled': True, 18:40:36 INFO - 'halt_on_failure': False, 18:40:36 INFO - 'name': 'check_screen_resolution'},), 18:40:36 INFO - 'run_cmd_checks_enabled': True, 18:40:36 INFO - 'sps_profile': False, 18:40:36 INFO - 'sps_profile_interval': 0, 18:40:36 INFO - 'suite': 'dromaeojs-e10s', 18:40:36 INFO - 'system_bits': '64', 18:40:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 18:40:36 INFO - 'title': 't-yosemite-r5-0023', 18:40:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 18:40:36 INFO - 'use_talos_json': True, 18:40:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 18:40:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 18:40:36 INFO - 'work_dir': 'build'} 18:40:36 INFO - ##### 18:40:36 INFO - ##### Running clobber step. 18:40:36 INFO - ##### 18:40:36 INFO - Running pre-action listener: _resource_record_pre_action 18:40:36 INFO - Running main action method: clobber 18:40:36 INFO - rmtree: /builds/slave/test/build 18:40:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 18:40:40 INFO - Running post-action listener: _resource_record_post_action 18:40:40 INFO - ##### 18:40:40 INFO - ##### Running read-buildbot-config step. 18:40:40 INFO - ##### 18:40:40 INFO - Running pre-action listener: _resource_record_pre_action 18:40:40 INFO - Running main action method: read_buildbot_config 18:40:40 INFO - Using buildbot properties: 18:40:40 INFO - { 18:40:40 INFO - "properties": { 18:40:40 INFO - "buildnumber": 4, 18:40:40 INFO - "product": "firefox", 18:40:40 INFO - "script_repo_revision": "production", 18:40:40 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs-e10s", 18:40:40 INFO - "repository": "", 18:40:40 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs-e10s", 18:40:40 INFO - "buildid": "20151111164246", 18:40:40 INFO - "slavename": "t-yosemite-r5-0023", 18:40:40 INFO - "pgo_build": "False", 18:40:40 INFO - "basedir": "/builds/slave/test", 18:40:40 INFO - "project": "", 18:40:40 INFO - "platform": "yosemite", 18:40:40 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 18:40:40 INFO - "slavebuilddir": "test", 18:40:40 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 18:40:40 INFO - "branch": "mozilla-central", 18:40:40 INFO - "repo_path": "mozilla-central", 18:40:40 INFO - "stage_platform": "macosx64", 18:40:40 INFO - "builduid": "fc049c5baadb4cf2aa9759ec2970dc9a", 18:40:40 INFO - "revision": "e86bdbfed16469a76af03f0682e215ec33b2ee74" 18:40:40 INFO - }, 18:40:40 INFO - "sourcestamp": { 18:40:40 INFO - "repository": "", 18:40:40 INFO - "hasPatch": false, 18:40:40 INFO - "project": "", 18:40:40 INFO - "branch": "mozilla-central-macosx64-talos", 18:40:40 INFO - "changes": [ 18:40:40 INFO - { 18:40:40 INFO - "category": null, 18:40:40 INFO - "files": [ 18:40:40 INFO - { 18:40:40 INFO - "url": null, 18:40:40 INFO - "name": "https://queue.taskcluster.net/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 18:40:40 INFO - } 18:40:40 INFO - ], 18:40:40 INFO - "repository": "", 18:40:40 INFO - "rev": "e86bdbfed16469a76af03f0682e215ec33b2ee74", 18:40:40 INFO - "who": "kwierso@gmail.com", 18:40:40 INFO - "when": 1447295251, 18:40:40 INFO - "number": 6651617, 18:40:40 INFO - "comments": "Merge inbound to central, a=merge", 18:40:40 INFO - "project": "", 18:40:40 INFO - "at": "Wed 11 Nov 2015 18:27:31", 18:40:40 INFO - "branch": "mozilla-central-macosx64-talos", 18:40:40 INFO - "revlink": "", 18:40:40 INFO - "properties": [ 18:40:40 INFO - [ 18:40:40 INFO - "buildid", 18:40:40 INFO - "20151111164246", 18:40:40 INFO - "Change" 18:40:40 INFO - ], 18:40:40 INFO - [ 18:40:40 INFO - "builduid", 18:40:40 INFO - "fc049c5baadb4cf2aa9759ec2970dc9a", 18:40:40 INFO - "Change" 18:40:40 INFO - ], 18:40:40 INFO - [ 18:40:40 INFO - "pgo_build", 18:40:40 INFO - "False", 18:40:40 INFO - "Change" 18:40:40 INFO - ] 18:40:40 INFO - ], 18:40:40 INFO - "revision": "e86bdbfed16469a76af03f0682e215ec33b2ee74" 18:40:40 INFO - } 18:40:40 INFO - ], 18:40:40 INFO - "revision": "e86bdbfed16469a76af03f0682e215ec33b2ee74" 18:40:40 INFO - } 18:40:40 INFO - } 18:40:40 INFO - Found installer url https://queue.taskcluster.net/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 18:40:40 INFO - Running post-action listener: _resource_record_post_action 18:40:40 INFO - ##### 18:40:40 INFO - ##### Running download-and-extract step. 18:40:40 INFO - ##### 18:40:40 INFO - Running pre-action listener: _resource_record_pre_action 18:40:40 INFO - Running main action method: download_and_extract 18:40:40 INFO - mkdir: /builds/slave/test/build/tests 18:40:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:40 INFO - https://queue.taskcluster.net/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 18:40:40 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/test_packages.json 18:40:40 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/test_packages.json 18:40:40 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 18:40:40 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 18:40:41 INFO - Downloaded 1149 bytes. 18:40:41 INFO - Reading from file /builds/slave/test/build/test_packages.json 18:40:41 INFO - Using the following test package requirements: 18:40:41 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:40:41 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:40:41 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 18:40:41 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:40:41 INFO - u'jsshell-mac.zip'], 18:40:41 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:40:41 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 18:40:41 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:40:41 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:40:41 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 18:40:41 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:40:41 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 18:40:41 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:40:41 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 18:40:41 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 18:40:41 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 18:40:41 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 18:40:41 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 18:40: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')]} 18:40:41 INFO - https://queue.taskcluster.net/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:40:41 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:40:41 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:40:41 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/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 18:40:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/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 18:40:42 INFO - Downloaded 17454448 bytes. 18:40:42 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 18:40:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:40:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:40:47 INFO - Return code: 0 18:40:47 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 18:40:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:47 INFO - https://queue.taskcluster.net/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 18:40:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:40:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:40:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/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 18:40:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/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 18:40:49 INFO - Downloaded 17454448 bytes. 18:40: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 18:40:49 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 18:40:49 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 18:40:54 INFO - Return code: 0 18:40:54 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')]} 18:40:54 INFO - https://queue.taskcluster.net/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 18:40:54 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:40:54 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:40:54 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/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 18:40:54 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/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 18:40:55 INFO - Downloaded 11131693 bytes. 18:40:55 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 18:40:55 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 18:40:55 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 18:40:56 INFO - Return code: 0 18:40:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:40:56 INFO - https://queue.taskcluster.net/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 18:40:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:40:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:40:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 18:40:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/N054OqWoSXyn9Y-hYQuwlA/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 18:40:59 INFO - Downloaded 108694037 bytes. 18:40:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:40:59 INFO - mkdir: /builds/slave/test/properties 18:40:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 18:40:59 INFO - Writing to file /builds/slave/test/properties/build_url 18:40:59 INFO - Contents: 18:40:59 INFO - build_url:https://queue.taskcluster.net/v1/task/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 18:40:59 INFO - Running post-action listener: _resource_record_post_action 18:40:59 INFO - Running post-action listener: set_extra_try_arguments 18:40:59 INFO - ##### 18:40:59 INFO - ##### Running populate-webroot step. 18:40:59 INFO - ##### 18:40:59 INFO - Running pre-action listener: _resource_record_pre_action 18:40:59 INFO - Running main action method: populate_webroot 18:40:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 18:40:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 18:40:59 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 18:40:59 INFO - '../fennec_ids.txt'], 18:40:59 INFO - 'tests': ['tcheck2']}, 18:40:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 18:40:59 INFO - '--tppagecycles', 18:40:59 INFO - '7'], 18:40:59 INFO - 'tests': ['tsvgm']}}, 18:40:59 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 18:40:59 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 18:40:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 18:40:59 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:40:59 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 18:40:59 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 18:40:59 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:40:59 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:59 INFO - 'talos_options': ['--e10s'], 18:40:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 18:40:59 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:59 INFO - 'tests': ['damp', 'tps']}, 18:40:59 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:40:59 INFO - 'talos_options': ['--e10s'], 18:40:59 INFO - 'tests': ['damp', 'tps']}, 18:40:59 INFO - 'g3': {'tests': ['dromaeo_dom']}, 18:40:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 18:40:59 INFO - 'other': {'tests': ['a11yr', 18:40:59 INFO - 'ts_paint', 18:40:59 INFO - 'tpaint', 18:40:59 INFO - 'sessionrestore', 18:40:59 INFO - 'sessionrestore_no_auto_restore']}, 18:40:59 INFO - 'other-e10s': {'talos_options': ['--e10s'], 18:40:59 INFO - 'tests': ['a11yr', 18:40:59 INFO - 'ts_paint', 18:40:59 INFO - 'tpaint', 18:40:59 INFO - 'sessionrestore', 18:40:59 INFO - 'sessionrestore_no_auto_restore']}, 18:40:59 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 18:40:59 INFO - 'tests': ['a11yr', 18:40:59 INFO - 'ts_paint', 18:40:59 INFO - 'tpaint', 18:40:59 INFO - 'sessionrestore', 18:40:59 INFO - 'sessionrestore_no_auto_restore']}, 18:40:59 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 18:40:59 INFO - 'tests': ['a11yr', 18:40:59 INFO - 'ts_paint', 18:40:59 INFO - 'tpaint', 18:40:59 INFO - 'sessionrestore', 18:40:59 INFO - 'sessionrestore_no_auto_restore']}, 18:40:59 INFO - 'other_l64': {'tests': ['a11yr', 18:40:59 INFO - 'ts_paint', 18:40:59 INFO - 'tpaint', 18:40:59 INFO - 'sessionrestore', 18:40:59 INFO - 'sessionrestore_no_auto_restore']}, 18:40:59 INFO - 'other_nol64': {'tests': ['a11yr', 18:40:59 INFO - 'ts_paint', 18:41:00 INFO - 'tpaint', 18:41:00 INFO - 'sessionrestore', 18:41:00 INFO - 'sessionrestore_no_auto_restore']}, 18:41:00 INFO - 'svgr': {'tests': ['tsvgx', 18:41:00 INFO - 'tsvgr_opacity', 18:41:00 INFO - 'tart', 18:41:00 INFO - 'tscrollx', 18:41:00 INFO - 'cart']}, 18:41:00 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 18:41:00 INFO - 'tests': ['tsvgx', 18:41:00 INFO - 'tsvgr_opacity', 18:41:00 INFO - 'tart', 18:41:00 INFO - 'tscrollx', 18:41:00 INFO - 'cart']}, 18:41:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:00 INFO - 'tests': ['tp5o']}, 18:41:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:00 INFO - 'talos_options': ['--e10s'], 18:41:00 INFO - 'tests': ['tp5o']}, 18:41:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:00 INFO - 'talos_options': ['--xperf_path', 18:41:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:41:00 INFO - 'tests': ['tp5n']}, 18:41:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 18:41:00 INFO - 'talos_options': ['--e10s', 18:41:00 INFO - '--xperf_path', 18:41:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 18:41:00 INFO - 'tests': ['tp5n']}}, 18:41:00 INFO - 'talos.zip': {'path': '', 18:41:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 18:41:00 INFO - Running post-action listener: _resource_record_post_action 18:41:00 INFO - ##### 18:41:00 INFO - ##### Running create-virtualenv step. 18:41:00 INFO - ##### 18:41:00 INFO - Running pre-action listener: _resource_record_pre_action 18:41:00 INFO - Running main action method: create_virtualenv 18:41:00 INFO - Creating virtualenv /builds/slave/test/build/venv 18:41:00 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 18:41:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 18:41:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 18:41:00 INFO - Using real prefix '/tools/python27' 18:41:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 18:41:01 INFO - Installing distribute.............................................................................................................................................................................................done. 18:41:05 INFO - Installing pip.................done. 18:41:05 INFO - Return code: 0 18:41:05 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 18:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:05 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 0x10df1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10defb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2836308e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de419f0>, '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 0x10dba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de358c8>, '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.iMXLQy1McM/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.UgTVGkwdgx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 18:41:05 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 18:41:05 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 18:41:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMXLQy1McM/Render', 18:41:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:41:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:41:05 INFO - 'HOME': '/Users/cltbld', 18:41:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:41:05 INFO - 'LOGNAME': 'cltbld', 18:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:05 INFO - 'MOZ_NO_REMOTE': '1', 18:41:05 INFO - 'NO_EM_RESTART': '1', 18:41:05 INFO - 'PAGER': '/bin/cat', 18:41:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:05 INFO - 'PWD': '/builds/slave/test', 18:41:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:41:05 INFO - 'SHELL': '/bin/bash', 18:41:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgTVGkwdgx/Listeners', 18:41:05 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 18:41:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:41:05 INFO - 'USER': 'cltbld', 18:41:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:41:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:05 INFO - 'XPC_FLAGS': '0x0', 18:41:05 INFO - 'XPC_SERVICE_NAME': '0', 18:41:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:41:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:05 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 18:41:05 INFO - Cleaning up... 18:41:05 INFO - Return code: 0 18:41:05 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 18:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:05 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 0x10df1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10defb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2836308e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de419f0>, '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 0x10dba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de358c8>, '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.iMXLQy1McM/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.UgTVGkwdgx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 18:41:05 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 18:41:05 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 18:41:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMXLQy1McM/Render', 18:41:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:41:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:41:05 INFO - 'HOME': '/Users/cltbld', 18:41:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:41:05 INFO - 'LOGNAME': 'cltbld', 18:41:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:05 INFO - 'MOZ_NO_REMOTE': '1', 18:41:05 INFO - 'NO_EM_RESTART': '1', 18:41:05 INFO - 'PAGER': '/bin/cat', 18:41:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:41:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:05 INFO - 'PWD': '/builds/slave/test', 18:41:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:41:05 INFO - 'SHELL': '/bin/bash', 18:41:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgTVGkwdgx/Listeners', 18:41:05 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 18:41:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:41:05 INFO - 'USER': 'cltbld', 18:41:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:41:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:41:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:05 INFO - 'XPC_FLAGS': '0x0', 18:41:05 INFO - 'XPC_SERVICE_NAME': '0', 18:41:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:41:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:06 INFO - Downloading/unpacking psutil>=0.7.1 18:41:06 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 18:41:06 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 18:41:06 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 18:41:06 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 18:41:06 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 18:41:06 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 18:41:08 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 18:41:09 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 18:41:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 18:41:09 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:41:09 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:41:09 INFO - Installing collected packages: psutil 18:41:09 INFO - Running setup.py install for psutil 18:41:09 INFO - building 'psutil._psutil_osx' extension 18:41:09 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 18:41:11 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 18:41:11 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 18:41:11 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 18:41:11 INFO - building 'psutil._psutil_posix' extension 18:41:11 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 18:41:11 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 18:41:11 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 18:41:11 INFO - ^ 18:41:11 INFO - 1 warning generated. 18:41:11 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 18:41:12 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 18:41:12 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 18:41:12 INFO - Successfully installed psutil 18:41:12 INFO - Cleaning up... 18:41:12 INFO - Return code: 0 18:41:12 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 18:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:12 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 0x10df1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10defb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2836308e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de419f0>, '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 0x10dba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de358c8>, '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.iMXLQy1McM/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.UgTVGkwdgx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 18:41:12 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 18:41:12 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 18:41:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMXLQy1McM/Render', 18:41:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:41:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:41:12 INFO - 'HOME': '/Users/cltbld', 18:41:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:41:12 INFO - 'LOGNAME': 'cltbld', 18:41:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:12 INFO - 'MOZ_NO_REMOTE': '1', 18:41:12 INFO - 'NO_EM_RESTART': '1', 18:41:12 INFO - 'PAGER': '/bin/cat', 18:41:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:41:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:12 INFO - 'PWD': '/builds/slave/test', 18:41:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:41:12 INFO - 'SHELL': '/bin/bash', 18:41:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgTVGkwdgx/Listeners', 18:41:12 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 18:41:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:41:12 INFO - 'USER': 'cltbld', 18:41:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:41:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:41:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:12 INFO - 'XPC_FLAGS': '0x0', 18:41:12 INFO - 'XPC_SERVICE_NAME': '0', 18:41:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:41:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:12 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 18:41:12 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 18:41:12 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 18:41:12 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 18:41:12 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 18:41:12 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 18:41:12 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 18:41:15 INFO - Downloading mozsystemmonitor-0.0.tar.gz 18:41:15 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 18:41:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 18:41:15 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 18:41:15 INFO - Installing collected packages: mozsystemmonitor 18:41:15 INFO - Running setup.py install for mozsystemmonitor 18:41:15 INFO - Successfully installed mozsystemmonitor 18:41:15 INFO - Cleaning up... 18:41:15 INFO - Return code: 0 18:41:15 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 18:41: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')]} 18:41:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41: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')]} 18:41:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41: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', '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 0x10df1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10defb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2836308e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de419f0>, '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 0x10dba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de358c8>, '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.iMXLQy1McM/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.UgTVGkwdgx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 18:41: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 18:41: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 blobuploader==1.2.4 18:41:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMXLQy1McM/Render', 18:41:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:41:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:41:15 INFO - 'HOME': '/Users/cltbld', 18:41:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:41:15 INFO - 'LOGNAME': 'cltbld', 18:41:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:15 INFO - 'MOZ_NO_REMOTE': '1', 18:41:15 INFO - 'NO_EM_RESTART': '1', 18:41:15 INFO - 'PAGER': '/bin/cat', 18:41:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:41:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:15 INFO - 'PWD': '/builds/slave/test', 18:41:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:41:15 INFO - 'SHELL': '/bin/bash', 18:41:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgTVGkwdgx/Listeners', 18:41:15 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 18:41:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:41:15 INFO - 'USER': 'cltbld', 18:41:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:41:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:41:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:15 INFO - 'XPC_FLAGS': '0x0', 18:41:15 INFO - 'XPC_SERVICE_NAME': '0', 18:41:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:41:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:16 INFO - Downloading/unpacking blobuploader==1.2.4 18:41:16 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 18:41:16 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 18:41:16 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 18:41:16 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 18:41:16 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 18:41:16 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 18:41:18 INFO - Downloading blobuploader-1.2.4.tar.gz 18:41:18 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 18:41:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 18:41:18 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 18:41:18 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 18:41:18 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 18:41:18 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 18:41:18 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 18:41:18 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 18:41:18 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 18:41:19 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 18:41:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 18:41:19 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 18:41:19 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 18:41:19 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 18:41:19 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 18:41:19 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 18:41:19 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 18:41:19 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 18:41:20 INFO - Downloading docopt-0.6.1.tar.gz 18:41:20 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 18:41:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 18:41:20 INFO - Installing collected packages: blobuploader, requests, docopt 18:41:20 INFO - Running setup.py install for blobuploader 18:41:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 18:41:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 18:41:20 INFO - Running setup.py install for requests 18:41:21 INFO - Running setup.py install for docopt 18:41:21 INFO - Successfully installed blobuploader requests docopt 18:41:21 INFO - Cleaning up... 18:41:21 INFO - Return code: 0 18:41:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41: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')]} 18:41:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41: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')]} 18:41:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:21 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 0x10df1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10defb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2836308e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de419f0>, '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 0x10dba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de358c8>, '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.iMXLQy1McM/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.UgTVGkwdgx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 18:41:21 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 18:41:21 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 18:41:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMXLQy1McM/Render', 18:41:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:41:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:41:21 INFO - 'HOME': '/Users/cltbld', 18:41:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:41:21 INFO - 'LOGNAME': 'cltbld', 18:41:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:21 INFO - 'MOZ_NO_REMOTE': '1', 18:41:21 INFO - 'NO_EM_RESTART': '1', 18:41:21 INFO - 'PAGER': '/bin/cat', 18:41:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:41:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:21 INFO - 'PWD': '/builds/slave/test', 18:41:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:41:21 INFO - 'SHELL': '/bin/bash', 18:41:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgTVGkwdgx/Listeners', 18:41:21 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 18:41:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:41:21 INFO - 'USER': 'cltbld', 18:41:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:41:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:41:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:21 INFO - 'XPC_FLAGS': '0x0', 18:41:21 INFO - 'XPC_SERVICE_NAME': '0', 18:41:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:41:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:41:21 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-ABKtHQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:41:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:41:21 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-RSJkrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:41:22 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-zxOvxl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:41:22 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-xCM4dm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:41:22 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-2nq988-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:41:22 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-LTpcVM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:41:22 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-j4km1x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:41:22 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-9jKIwv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:41:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:41:22 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-4nWnJk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:41:23 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-L99wqk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:41:23 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-FhlvaP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:41:23 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-s5cfJy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:41:23 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-uLBG5e-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:41:23 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-tgsGeI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:23 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-7NW2j1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:41:23 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-jCABiC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:41:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:41:24 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-2X3w5t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:41:24 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 18:41:24 INFO - Running setup.py install for manifestparser 18:41:24 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 18:41:24 INFO - Running setup.py install for mozcrash 18:41:24 INFO - Running setup.py install for mozdebug 18:41:24 INFO - Running setup.py install for mozdevice 18:41:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 18:41:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 18:41:24 INFO - Running setup.py install for mozfile 18:41:25 INFO - Running setup.py install for mozhttpd 18:41:25 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 18:41:25 INFO - Running setup.py install for mozinfo 18:41:25 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 18:41:25 INFO - Running setup.py install for mozInstall 18:41:25 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 18:41:25 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 18:41:25 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 18:41:25 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 18:41:25 INFO - Running setup.py install for mozleak 18:41:25 INFO - Running setup.py install for mozlog 18:41:26 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 18:41:26 INFO - Running setup.py install for moznetwork 18:41:26 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 18:41:26 INFO - Running setup.py install for mozprocess 18:41:26 INFO - Running setup.py install for mozprofile 18:41:26 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 18:41:26 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 18:41:26 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 18:41:26 INFO - Running setup.py install for mozrunner 18:41:26 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 18:41:26 INFO - Running setup.py install for mozscreenshot 18:41:27 INFO - Running setup.py install for moztest 18:41:27 INFO - Running setup.py install for mozversion 18:41:27 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 18:41:27 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 18:41:27 INFO - Cleaning up... 18:41:27 INFO - Return code: 0 18:41:27 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:27 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 0x10df1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10defb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2836308e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de419f0>, '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 0x10dba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de358c8>, '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.iMXLQy1McM/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.UgTVGkwdgx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 18:41:27 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 18:41:27 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 18:41:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMXLQy1McM/Render', 18:41:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:41:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:41:27 INFO - 'HOME': '/Users/cltbld', 18:41:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:41:27 INFO - 'LOGNAME': 'cltbld', 18:41:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:27 INFO - 'MOZ_NO_REMOTE': '1', 18:41:27 INFO - 'NO_EM_RESTART': '1', 18:41:27 INFO - 'PAGER': '/bin/cat', 18:41:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:41:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:27 INFO - 'PWD': '/builds/slave/test', 18:41:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:41:27 INFO - 'SHELL': '/bin/bash', 18:41:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgTVGkwdgx/Listeners', 18:41:27 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 18:41:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:41:27 INFO - 'USER': 'cltbld', 18:41:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:41:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:41:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:27 INFO - 'XPC_FLAGS': '0x0', 18:41:27 INFO - 'XPC_SERVICE_NAME': '0', 18:41:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:41:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 18:41:27 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-mGLyU9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 18:41:28 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)) 18:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 18:41:28 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-0LPKm7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 18:41:28 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)) 18:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 18:41:28 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-8fYwgp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 18:41:28 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)) 18:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 18:41:28 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-7tkE1d-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 18:41:28 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)) 18:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 18:41:28 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-uHLVW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 18:41:28 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)) 18:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 18:41:28 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-rnhz9J-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 18:41:28 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)) 18:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 18:41:28 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-fyBkeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 18:41:28 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)) 18:41:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 18:41:28 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-o8M3ty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 18:41:29 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)) 18:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 18:41:29 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-F1Dt5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 18:41:29 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)) 18:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 18:41:29 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-cXmAiZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 18:41:29 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)) 18:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 18:41:29 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-u0ofpf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 18:41:29 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)) 18:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 18:41:29 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-zL9995-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 18:41:29 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)) 18:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 18:41:29 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-qqJi_i-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 18:41:29 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)) 18:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 18:41:29 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-aVNVHP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 18:41:29 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)) 18:41:29 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:29 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-QGLB6N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 18:41:30 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)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 18:41:30 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-467G4c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 18:41:30 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)) 18:41:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 18:41:30 INFO - Running setup.py (path:/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/pip-KSpBQ9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 18:41:30 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)) 18:41:30 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)) 18:41:30 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)) 18:41:30 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)) 18:41:30 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)) 18:41:30 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)) 18:41:30 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 18:41:30 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 18:41:30 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 18:41:30 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 18:41:30 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 18:41:30 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 18:41:30 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 18:41:33 INFO - Downloading blessings-1.5.1.tar.gz 18:41:33 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 18:41:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 18:41:33 INFO - Installing collected packages: blessings 18:41:33 INFO - Running setup.py install for blessings 18:41:33 INFO - Successfully installed blessings 18:41:33 INFO - Cleaning up... 18:41:33 INFO - Return code: 0 18:41:33 INFO - Done creating virtualenv /builds/slave/test/build/venv. 18:41:33 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:41:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:41:33 INFO - Reading from file tmpfile_stdout 18:41:33 INFO - Current package versions: 18:41:33 INFO - blessings == 1.5.1 18:41:33 INFO - blobuploader == 1.2.4 18:41:33 INFO - docopt == 0.6.1 18:41:33 INFO - manifestparser == 1.1 18:41:33 INFO - mozInstall == 1.12 18:41:33 INFO - mozcrash == 0.16 18:41:33 INFO - mozdebug == 0.1 18:41:33 INFO - mozdevice == 0.47 18:41:33 INFO - mozfile == 1.2 18:41:33 INFO - mozhttpd == 0.7 18:41:33 INFO - mozinfo == 0.9 18:41:33 INFO - mozleak == 0.1 18:41:33 INFO - mozlog == 3.0 18:41:33 INFO - moznetwork == 0.27 18:41:33 INFO - mozprocess == 0.22 18:41:33 INFO - mozprofile == 0.27 18:41:33 INFO - mozrunner == 6.11 18:41:33 INFO - mozscreenshot == 0.1 18:41:33 INFO - mozsystemmonitor == 0.0 18:41:33 INFO - moztest == 0.7 18:41:33 INFO - mozversion == 1.4 18:41:33 INFO - psutil == 3.1.1 18:41:33 INFO - requests == 1.2.3 18:41:33 INFO - wsgiref == 0.1.2 18:41:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 18:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 18:41:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:41:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 18:41:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 18:41:33 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 0x10df1e490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10defb228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb2836308e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10de419f0>, '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 0x10dba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de358c8>, '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.iMXLQy1McM/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.UgTVGkwdgx/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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 18:41:33 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 18:41:33 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 18:41:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMXLQy1McM/Render', 18:41:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:41:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:41:33 INFO - 'HOME': '/Users/cltbld', 18:41:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:41:33 INFO - 'LOGNAME': 'cltbld', 18:41:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:41:33 INFO - 'MOZ_NO_REMOTE': '1', 18:41:33 INFO - 'NO_EM_RESTART': '1', 18:41:33 INFO - 'PAGER': '/bin/cat', 18:41:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:41:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:41:33 INFO - 'PWD': '/builds/slave/test', 18:41:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:41:33 INFO - 'SHELL': '/bin/bash', 18:41:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgTVGkwdgx/Listeners', 18:41:33 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 18:41:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:41:33 INFO - 'USER': 'cltbld', 18:41:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:41:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:41:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:41:33 INFO - 'XPC_FLAGS': '0x0', 18:41:33 INFO - 'XPC_SERVICE_NAME': '0', 18:41:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:41:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 18:41:34 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)) 18:41:34 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)) 18:41:34 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)) 18:41:34 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)) 18:41:34 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)) 18:41:34 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)) 18:41:34 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)) 18:41:34 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)) 18:41:34 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)) 18:41:34 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)) 18:41:34 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)) 18:41:34 INFO - Cleaning up... 18:41:34 INFO - Return code: 0 18:41:34 INFO - Running post-action listener: _resource_record_post_action 18:41:34 INFO - Running post-action listener: _start_resource_monitoring 18:41:34 INFO - Starting resource monitoring. 18:41:34 INFO - ##### 18:41:34 INFO - ##### Running install step. 18:41:34 INFO - ##### 18:41:34 INFO - Running pre-action listener: _resource_record_pre_action 18:41:34 INFO - Running main action method: install 18:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 18:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 18:41:34 INFO - Reading from file tmpfile_stdout 18:41:34 INFO - Detecting whether we're running mozinstall >=1.0... 18:41:34 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 18:41:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 18:41:34 INFO - Reading from file tmpfile_stdout 18:41:34 INFO - Output received: 18:41:34 INFO - Usage: mozinstall [options] installer 18:41:34 INFO - Options: 18:41:34 INFO - -h, --help show this help message and exit 18:41:34 INFO - -d DEST, --destination=DEST 18:41:34 INFO - Directory to install application into. [default: 18:41:34 INFO - "/builds/slave/test"] 18:41:34 INFO - --app=APP Application being installed. [default: firefox] 18:41:34 INFO - mkdir: /builds/slave/test/build/application 18:41:34 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'] 18:41:34 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 18:42:17 INFO - Reading from file tmpfile_stdout 18:42:17 INFO - Output received: 18:42:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 18:42:17 INFO - Running post-action listener: _resource_record_post_action 18:42:17 INFO - ##### 18:42:17 INFO - ##### Running run-tests step. 18:42:17 INFO - ##### 18:42:17 INFO - Running pre-action listener: _resource_record_pre_action 18:42:17 INFO - Running main action method: run_tests 18:42:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 18:42:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 18:42:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 18:42:17 INFO - 2015-11-11 18:42:17.916 screenresolution[1620:7575] starting screenresolution argv=screenresolution get 18:42:17 INFO - 2015-11-11 18:42:17.920 screenresolution[1620:7575] Display 0: 1600x1200x32@60 18:42:17 INFO - 2015-11-11 18:42:17.928 screenresolution[1621:7577] starting screenresolution argv=screenresolution list 18:42:17 INFO - Available Modes on Display 0 18:42:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 18:42:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 18:42:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 18:42:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 18:42:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 18:42:18 INFO - Intel HD Graphics 3000: 18:42:18 INFO - Chipset Model: Intel HD Graphics 3000 18:42:18 INFO - Type: GPU 18:42:18 INFO - Bus: Built-In 18:42:18 INFO - VRAM (Total): 512 MB 18:42:18 INFO - VRAM (Dynamic, Max): 10 18:42:18 INFO - Vendor: Intel (0x8086) 18:42:18 INFO - Device ID: 0x0116 18:42:18 INFO - Revision ID: 0x0009 18:42:18 INFO - Displays: 18:42:18 INFO - Display: 18:42:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 18:42:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 18:42:18 INFO - Display Serial Number: 1600x1200 60 18:42:18 INFO - Main Display: Yes 18:42:18 INFO - Mirror: Off 18:42:18 INFO - Online: Yes 18:42:18 INFO - Rotation: Supported 18:42:18 INFO - Return code: 0 18:42:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 18:42:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 18:42:18 INFO - Python 2.7.3 18:42:18 INFO - Return code: 0 18:42:18 INFO - grabbing minidump binary from tooltool 18:42:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 18:42:18 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 0x10de419f0>, '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 0x10dba1db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10de358c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 18:42:18 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 18:42:18 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 18:42:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 18:42:18 INFO - Return code: 0 18:42:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 18:42:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 18:42:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 18:42:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 18:42:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 18:42:18 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/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0023', '--webServer', 'localhost'] in /builds/slave/test/build 18:42:18 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/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0023 --webServer localhost 18:42:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.iMXLQy1McM/Render', 18:42:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 18:42:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 18:42:18 INFO - 'HOME': '/Users/cltbld', 18:42:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 18:42:18 INFO - 'LOGNAME': 'cltbld', 18:42:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 18:42:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 18:42:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 18:42:18 INFO - 'MOZ_NO_REMOTE': '1', 18:42:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 18:42:18 INFO - 'NO_EM_RESTART': '1', 18:42:18 INFO - 'PAGER': '/bin/cat', 18:42:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 18:42:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 18:42:18 INFO - 'PWD': '/builds/slave/test', 18:42:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 18:42:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 18:42:18 INFO - 'SHELL': '/bin/bash', 18:42:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.UgTVGkwdgx/Listeners', 18:42:18 INFO - 'TMPDIR': '/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/', 18:42:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 18:42:18 INFO - 'USER': 'cltbld', 18:42:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 18:42:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 18:42:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 18:42:18 INFO - 'XPC_FLAGS': '0x0', 18:42:18 INFO - 'XPC_SERVICE_NAME': '0', 18:42:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 18:42:18 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/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0023', '--webServer', 'localhost'] with output_timeout 3600 18:42:18 INFO - mozversion INFO | application_buildid: 20151111164246 18:42:18 INFO - mozversion INFO | application_changeset: e86bdbfed16469a76af03f0682e215ec33b2ee74 18:42:18 INFO - mozversion INFO | application_display_name: Nightly 18:42:18 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 18:42:18 INFO - mozversion INFO | application_name: Firefox 18:42:18 INFO - mozversion INFO | application_remotingname: firefox 18:42:18 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 18:42:18 INFO - mozversion INFO | application_vendor: Mozilla 18:42:18 INFO - mozversion INFO | application_version: 45.0a1 18:42:18 INFO - mozversion INFO | platform_buildid: 20151111164246 18:42:18 INFO - mozversion INFO | platform_changeset: e86bdbfed16469a76af03f0682e215ec33b2ee74 18:42:18 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 18:42:18 INFO - mozversion INFO | platform_version: 45.0a1 18:42:18 INFO - 2015-11-11 18:42:18,734 DEBUG : using testdate: 1447296138 18:42:18 INFO - 2015-11-11 18:42:18,734 DEBUG : actual date: 1447296138 18:42:18 INFO - 2015-11-11 18:42:18,744 INFO : starting webserver on 'localhost:49275' 18:42:18 INFO - 2015-11-11 18:42:18,745 INFO : Starting test suite t-yosemite-r5-0023.e 18:42:18 INFO - 2015-11-11 18:42:18,745 INFO : Starting test dromaeo_css 18:42:18 INFO - 2015-11-11 18:42:18,746 DEBUG : operating with platform_type : mac_ 18:42:18 INFO - 2015-11-11 18:42:18,746 INFO : Initialising browser for dromaeo_css test... 18:42:18 INFO - 2015-11-11 18:42:18,774 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpnPWWcz/profile http://localhost:49275/getInfo.html 18:42:23 INFO - 2015-11-11 18:42:23,432 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 18:42:23 INFO - 2015-11-11 18:42:23,433 DEBUG : BROWSER_OUTPUT: colorDepth:24 18:42:23 INFO - 2015-11-11 18:42:23,433 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 18:42:23 INFO - 2015-11-11 18:42:23,433 DEBUG : BROWSER_OUTPUT: __metrics 18:42:24 INFO - 2015-11-11 18:42:24,153 INFO : Browser initialized. 18:42:24 INFO - 2015-11-11 18:42:24,153 INFO : Running cycle 1/1 for dromaeo_css test... 18:42:24 INFO - 2015-11-11 18:42:24,153 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpnPWWcz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 18:42:36 INFO - 2015-11-11 18:42:36,612 DEBUG : BROWSER_OUTPUT: RSS: Main: 240828416 18:42:36 INFO - 2015-11-11 18:42:36,612 DEBUG : BROWSER_OUTPUT: 18:43:26 INFO - 2015-11-11 18:43:26,490 DEBUG : BROWSER_OUTPUT: 1447296206486 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] 18:45:37 INFO - 2015-11-11 18:45:37,131 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49275/tests/dromaeo/cssquery-ext.html) 18:45:38 INFO - 2015-11-11 18:45:38,299 DEBUG : BROWSER_OUTPUT: RSS: Main: 263720960 18:45:38 INFO - 2015-11-11 18:45:38,299 DEBUG : BROWSER_OUTPUT: 18:48:40 INFO - 2015-11-11 18:48:40,501 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-ext.html (next: http://localhost:49275/tests/dromaeo/cssquery-jquery.html) 18:48:41 INFO - 2015-11-11 18:48:41,087 DEBUG : BROWSER_OUTPUT: RSS: Main: 270307328 18:48:41 INFO - 2015-11-11 18:48:41,087 DEBUG : BROWSER_OUTPUT: 18:51:42 INFO - 2015-11-11 18:51:42,835 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49275/tests/dromaeo/cssquery-mootools.html) 18:51:43 INFO - 2015-11-11 18:51:43,418 DEBUG : BROWSER_OUTPUT: RSS: Main: 275460096 18:51:43 INFO - 2015-11-11 18:51:43,418 DEBUG : BROWSER_OUTPUT: 18:54:45 INFO - 2015-11-11 18:54:45,239 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49275/tests/dromaeo/cssquery-prototype.html) 18:54:45 INFO - 2015-11-11 18:54:45,825 DEBUG : BROWSER_OUTPUT: RSS: Main: 277647360 18:54:45 INFO - 2015-11-11 18:54:45,825 DEBUG : BROWSER_OUTPUT: 18:57:48 INFO - 2015-11-11 18:57:48,608 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49275/tests/dromaeo/cssquery-yui.html) 18:57:49 INFO - 2015-11-11 18:57:49,234 DEBUG : BROWSER_OUTPUT: RSS: Main: 282906624 18:57:49 INFO - 2015-11-11 18:57:49,234 DEBUG : BROWSER_OUTPUT: 19:00:51 INFO - 2015-11-11 19:00:51,617 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/dromaeo/cssquery-yui.html (next: http://localhost:49275/tests/dromaeo/cssquery-dojo.html) 19:00:51 INFO - 2015-11-11 19:00:51,876 DEBUG : BROWSER_OUTPUT: RSS: Main: 288026624 19:00:51 INFO - 2015-11-11 19:00:51,876 DEBUG : BROWSER_OUTPUT: 19:00:51 INFO - 2015-11-11 19:00:51,876 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:00:51 INFO - 2015-11-11 19:00:51,876 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:00:51 INFO - 2015-11-11 19:00:51,877 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:00:51 INFO - 2015-11-11 19:00:51,877 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:00:51 INFO - 2015-11-11 19:00:51,877 DEBUG : BROWSER_OUTPUT: |0;dojo.html;2533.885975131119;2596.9350766230846;2601.3626661467933;2650.8409495430265;2662.6405435266256;4501.527339629337;4511.706739061959;4541.069080838429;4551.908961820762;4557.703749256296;4383.890402739933;4454.594518959758;4487.596116349528;4598.172328980782;4598.70108442951;4196.874093777192;4303.074838909633;4341.261985462479;4366.716163449381;4375.7593332366705;366.32288487408334;4260.339647354665;4275.636570891478;4364.061726728753;4411.27214009688;4292.828286868522;4295.978520107379;4297.785110744481;4334.176506463762;4338.522762496123;4268.445102136733;4285.250081235771;4315.805788739514;4349.84775532858;4379.956200438019;4078.0416602098485;4173.373993900909;4182.853600124012;4282.057947251599;4334.891627709301;4300.182965236626;4372.803223854934;4515.96132889434;4541.296099104644;4607.677462577621;4632.490426053131;4835.927461088087;4852.514748525155;4868.659193856396;4876.073546026244;4713.717176969359;4792.688475249098;4799.568038876483;4855.878603034917;4916.434610019822;4555.612772914339;4556.817727290938;4559.110973360163;4576.565226303529;4599.540045995407;4759;4903.8966232598095;4973.502649734997;4995.100881841231;5037.0681423936685;4624.907501849944;4671.509491503343;4691.437027556715;4718.127146477913;4757.26262429324;4787.994521150597;4872.829450969199;4874.390701162355;4875.07373599015;4915.877103072452;4549.772511374418;4616.838410655611;4674.158651442773;4780.856574302707;4831.275308703723;4786.8085276588545;4790.784414701347;4809.014152098812;4813.229883218738;4859.2954021667365;3702.444633305026;3730.086128898383;3735.916584190609;3753.7935413551972;3772.1135533149686;3297.274599588087;3299.736021118305;3355.647656996029;3402.914927126792;3424.9143771405415;4445.755483448442;4515.228716298416;4530.320451932236;4541.931871021938;4590.816367345269;4872.634552408584;4908.950910490921;4910.8281210157475;4923.08922849274;4964.007198560303;4254.106637606137;4419.9337009944875;4454.465464144323;4495.752733599684;4532.093581283756;4244.978775106105;4254.255505286563;4274.123804620045;4302.290122129876;4309.978450107729;4803;5041.420236672683;5043.193089105725;5044.596432285482;5046.39443266803;4785.473597904158;4845.781939812788;4846.539578740014;4852.539008794159;4896.069746748107;5011.047900898818;5011.473795251446;5036.169032109661;5039.420466646383;5126;4648.883777905444;4707.693999889996;4793.089313030513;4811.639127065554;4857.562819346276;4737.478877323423;4820;4833.685810422311;4868.902621947612;4872.293517440023;4751.809927602857;4768.308595253599;4771.427428708438;4783.928241076456;4804.927926081042;4530.184566778012;4577.0845830833305;4652.255639097863;4725.834595789131;4728.550787675165;4641.976790116028;4649.279361698942;4656.8137274508645;4660.883477912944;4701.388819453449;4672.252439609646;4681.461631912373;4707.105649926503;4781.952180478151;4821.879453013703;4437.312216606431;4526.909461810811;4566.954330456653;4575.7483338416705;4680.5085466025575 19:00:51 INFO - 2015-11-11 19:00:51,877 DEBUG : BROWSER_OUTPUT: |1;ext.html;448.51336300114394;457.3848174205694;463.12931688425755;479.58276299619337;488.430977910734;31238.84380578097;32332.35335293293;32535.837320813393;32838.343233135325;33046.86054824788;34740.47889281663;34746.478802817976;34750.8262458688;35084.64915350852;35266.2946741065;7350.191478937326;7494.812629684247;7527.623618819064;7558;7637.045369328834;7361.9631901840685;7450.925490745078;7464.440166987471;7542.245775422469;7561.7731468056045;7429.182789893108;7495.2130026346995;7503.287187717158;7577.810554736148;7595.278448547379;7406.62966851658;7485.438592105614;7502.962485187593;7517.624118794039;7581.3555847753005;7466.701331946716;7467.887981680279;7468.47720659554;7477.551346919148;7575.545467271982;32486;32534.349313013845;32561.348773024645;32943.34113317744;32968.505472417935;2499.3751562109474;2506.699196096462;2596.065416450095;2655.292503257191;2814.4667365398873;22009;22667.77332226673;23083.769162308497;23094.884525577432;23473.41316467085;1880.8119188081218;1890.8392786613153;1895.4597939587288;1899.373206841739;1910.8184722451344;212993;213119;214180;214981;215073;45402.545974540495;45986.31020534695;49755.502444975085;51352.229716554284;51641.741791291555;47699;48079.278810817865;48449.273260901115;49215;49343.25985110226;13401.66495837612;13460.125091868997;13524.45902163922;13609.863901360859;13624;10165;10194.286399951932;10294.279400441897;10322.896771032194;10506;15573.454929077428;15718.449854255276;15785.526434206991;15787.447439339569;16059.919700401657;6337.479005038757;6500.837479063061;6518.087467754518;6519.902201466982;6532.5753826001155;730.6310313291754;761.7410080572632;795.6697970342243;833.8499070167306;840.7940054686641;22832.200872969366;22834.42913927165;23153.189638362914;23157.652635210485;23327;809.6761295481855;814.8125931035777;853.108501615813;869.4565896314804;872.7120050383359;12460.376981150906;12521.186122901981;12542;12778.872211277954;12816.935915320364;241384;244138;246325;247471;247785;43833.34249986253;43895.12209755787;43913.78043109764;44198.55801442009;44286.11427771427;1111.7109551516503;1131.6548452722;1134.0983917785381;1141.4863311509853;1142.3031950510183;23506.529869402857;23597.764022359555;23601;23806.523869522167;23808.761912381346;37109;37580.87257382283;38020.61979380171;38030.80984595059;38385.54530092305;209844;211857;212259;213038;214059;24760.752392475846;25081.372965676004;25559.105431309814;25978.35054123662;26130.73869261283;32886.34227315488;33170.336593267515;33563.16092097717;33599.16002099967;33672;28381.822361253886;28475;28574.714252858037;28637;28832.279193020342;27119.72880271251;27496.312592184557;27786.44427111487;27830.469324187365;28059.43881122407;27635.170944871687;27715.861420692767;28288.15135545937;28564.31799629658;28604;24422.63366049475;25122.748772512772;25127;25625.487490249718;25752.742472575035;19158.712619311;19404.320848770225;19526.8047319525;19537.60924781525;19771 19:00:51 INFO - 2015-11-11 19:00:51,879 DEBUG : BROWSER_OUTPUT: |2;jquery.html;274.7197858184653;275.6939796825523;276.69010708007033;277.0787132783494;287.9222609895328;11076.501557429914;13691.452341906324;13955.720885582283;14084;14567.125972441661;12250.93874530626;14511.637209069779;14803.777943330831;15070.47253346133;15103.62240943977;4241.384999175118;4278.058827058042;4337.110892267094;4396.714213576107;4407.07451435199;4303.117860838521;4334.306510958248;4383.693141480097;4391.5608439155985;4402.889927751816;3128.593282873235;3263.543103965435;4332.111917057012;4358.956410435887;4636.165490211761;4626.398568186114;4756.143894099061;4832.444268909086;4844.467108618049;4854.951450485503;4020.1356708307853;4120.072983578671;4145.813438395249;4166.1251137261215;4172.937405938914;17279;17361.565960850952;17398.21708023142;17585.296588136458;17674.469765907044;1558.9688206235812;1563.3433957737777;1656.9337226510925;1702.825050715015;1792.1935129191786;10703;10935.179861510418;10969.341839489576;11302.886971130265;11436.142289328334;1284.2166278570064;1318.3605951113702;1334.252818421687;1364.624728199743;1381.5371850430117;47063.29405058927;47375;47710.76144619255;47822;49404.50595494071;7639.236076392316;7738.380929525624;7949.046114466301;7955.801104972306;8002.239787220205;9661.806763864683;9665.468399238109;9667.806643867083;9796.461194634363;9807.803843923082;6206.286277078194;6335.714892829834;6362.6818659067785;6386;6408.61548307103;6349.825282322785;6365.681715914186;6371.23545174582;6399.584027038228;6414.422701956753;4640.071985602893;4669.649776266793;4693.671442998957;4710.6702530823195;4823.324734537167;1371.4925477573163;1387.7918312253244;1388.1046724862408;1389.6525868532867;1392.6239915222834;342.4982400782865;348.0640794895068;729.4383324839949;775.2673723331397;872.7643536245179;8137.5931203439595;8319.417640765088;8634.827303453896;8668.133186681407;8668.306535477146;338.7933360650002;348.8238439588043;355.9252556963015;357.44952772730227;357.613777120709;4591.9081618367445;4821.108095002365;5157.819476318311;5176.792928282902;5318.069337865858;292253;296497;299078;299243;300655;50377;54684.72657636686;58608.41391586115;59748.70125649344;59874.40125598775;395.6281095769967;403.8808551477321;404.66210714054097;404.9128091075413;408.94479245302097;8727.258183054511;8876.51179185151;8947.821043579223;8965.372423930263;9006.50464224474;27444.862775685993;27697.58453623157;28188.577171342036;28214.43571128607;28356.574651379833;37268.254634907695;37465.4380184292;37982;38070;38217;4864.221724524059;4950.504949505021;4964.578010869117;5027.7234752087525;5031.169856973558;9337.906620933976;9409;9526.809463810823;9657.613695452103;9663.951680241555;7992.280694737501;8102.554359510284;8291.83416331658;8299.128591498047;8379.748607541784;7680.423968202295;7929.920700792918;8123.7969050771835;8217.534739578223;8264.462809917337;8335.874961875455;8456.915430845613;8613.95693021556;8682.956585217033;8683.609237584451;5021.497850215095;5088.135017047185;5100.38795344561;5100.413452453015;5171.92242116361;8175.836483270183;8344.123866993878;8488.066312705474;8509.489430634181;8588.312934965063 19:00:51 INFO - 2015-11-11 19:00:51,882 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1428.6214153249387;1444.6677264229234;1460.4523303761096;1476.5496523560316;1522.4062615579926;5747.827565173052;6061.87876242476;6376.649284289368;6696.263411024789;6777.085093512381;6323.462505687022;6450.7742229022;6523.967380163104;6597.769078082268;6616.437602803768;1809.6018875847326;1843.612841303328;1846.7414561961336;1866.8413184879234;1874.3252429125505;1822.3439561757757;1846.9630607387844;1858.8977606231651;1875.8968256745873;1895.469268604793;1842.9262829486804;1870.6071724937779;1871.0270659257178;1892.6120145370166;1897.0704354866086;1756.0868348458794;1792.507060558344;1797.0924683035114;1805.3861687026342;1818.4271954334342;1828.8354048135732;1863.394396821025;1865.8880467171878;1877.6150889067708;1881.604862978776;6437.324080971477;6541.182352205974;6577.309382514863;6608.735650573972;6635.43598794103;3904.7657140571655;3931.8623848165175;3990.3615421532418;4003.899902502432;4058.2492238935597;2118.1103936346617;2140.892955352226;2370.7155141383146;2440.389902524369;2470.493548822505;724.3336130759714;743.1453828097731;745.0537816972414;748.5097261293861;755.5051441305953;8658.307335413152;8659.350548708871;8663.220310172052;8762.386632935697;8797.164269394398;3631.418972964313;3645.671889529955;3681.834317455667;3683.852645894188;3686.0047787097333;7540.245975402526;7553.660085296175;7570.924290757132;7612.657430415645;7613.352865006536;4030.8992275193355;4060.2285565743005;4061.248668996245;4073.490813648294;4128.637549608622;3665.8533658653887;3687.870924517683;3707.2400157967554;3729.179580492287;3734.290484807878;3088.90733278002;3091.984540077285;3125.968740312613;3162.778605497639;3163.620365556148;1022.320157095538;1035.9896401035894;1040.9011143941314;1046.6546039806844;1050.7425680708122;1066.3069005146717;1084.7017070305728;1102.9558817647364;1103.1340397787699;1111.988090837334;6208.627482351073;6220.191375121205;6248.718807653667;6277;6278.246610406781;369.4236990295148;377.61483287047605;377.6186052087357;378.75002498350955;380.3420083255983;4845.806167753321;4858.5384388483035;4867.148249056401;4909.239067944474;4922.310876477296;7526.849463010709;7821.061472623322;7876.369890408753;7896.289333959971;7933.523988560705;7744.728934487266;7804.882926756103;7813.804654883674;7865.370770338359;7869.842603147905;5887.558433117533;6044.214252147281;6048.606840555438;6164.137020817089;6237.594556353823;6193;6196.876062478816;6228.626282423069;6238.282597501164;6242.968785156045;6834.965825170842;6926.688299026657;6975.441964642715;6998.580085194904;7034.191068027242;6843.965780171067;7161.606111663908;7206.639668016683;7212.783616491513;7279.417646588367;5806.390329015392;5890.14592884038;5902.321233058082;5908.852278693067;5915.40845915405;5753.683547404766;6244.594101383395;6355.777547785805;6371.872562548816;6393.1369265148605;5831.183634291117;5858.736356864037;5861.472467477947;5884.617499862496;5896.204012458435;5733.397993210653;5783.566232532661;5825.0679891217205;5833.416658334133;5843.2403787507355;5898.793542226002;5930.169776231417;5938.703064846827;5949.553783466344;5949.613275137102;5126.820561280487;5342.492463215988;5397.622166448311;5423.972880135574;5451.56387488992;4924.261360795909;5035.118854200427;5315.973420132875;5377.650452720561;5387.676739395649 19:00:51 INFO - 2015-11-11 19:00:51,884 DEBUG : BROWSER_OUTPUT: |4;prototype.html;255.7429783068017;261.24239704855927;261.4692174884983;261.47052219256017;265.42800265428;4941.061198372316;4991.999999999995;5027.849164525061;5046.621503387242;5070.594352451804;4967.329410529577;4974.502549745023;5005.824796132136;5012.997400519892;5015.598752099832;3893.0462036801023;3906.1015966327764;3913.3738601823716;3914.138889444332;3962.6829853611644;3880.2821478026513;3898.259330727167;3907.6873850092065;3935.8425662973445;3958.4853968984135;3854.710896682746;3866.5360156781085;3897.9025524361978;3898.3567711327596;3906.199229158016;3696.0944568580735;3777.3956167013284;3795.221979494225;3824.292505886392;3849.3840985442193;3191.7287030602192;3197.776155669104;3207.0378886334006;3234.514822776579;3284.293876816496;4827.903441931142;4862.465128835825;4884.3650325457465;4892.902141957141;4910.263460480921;4180.184863951531;4205.621494065518;4213.789310534461;4222.113356195203;4237.724547904377;4982.17794063979;5119.539241468248;5119.66722163062;5128;5247.501487358695;3581.982090089559;3586.8565257389673;3591.1740299730945;3598.334308152974;3630.49173115764;5318.840434786963;5422.457754224546;5436.075867102602;5506.03644362235;5518.779248830042;3641.5630124385243;3646.8176591170336;3654.561452625702;3662.285854258394;3678.6321367863;3686.889393318205;3727.5713292971654;3760.9435858462143;3762.924741505209;3767.830447629863;4299.957000429956;4311.1808756336195;4314.784260787011;4322.113966636832;4327.502337231196;5214.504622060898;5248.973755131276;5252.133397989365;5291.074062039204;5318.521333080042;1328.1632571479906;1369.9931500342634;1371.4240019191964;1373.176094343386;1375.7454870848726;881.6209030116983;887.316766090107;903.0202230579763;907.1518130547959;908.8591268353416;5012.799488020439;5017.272495488134;5026.09530284545;5050;5107.97446012775;5496;5536.501714845684;5593.74828132735;5595.21666966625;5615.8876822464135;5023.949760502422;5027;5052.090623687698;5105.566026887682;5131.4868513148385;2967.6438827340858;3029.8939537116535;3058.1895797613206;3097.132802815215;3103.8603262853226;5643;5671.6597004179885;5673.716314184357;5725.541956643458;5736.053551164095;5632.464915832989;5679.403662615448;5713.143028545752;5717.656940583578;5719.256496655408;5659.320881494247;5683.204351390808;5698.259226300637;5736.368999410061;5744.856378590569;5268.157094864803;5367;5369.758360873848;5463.890722185454;5518.365387980433;5309.097453433003;5361.865953351197;5401.135818269216;5419.756110974937;5424.864378390414;5507.917381239205;5645.463680950304;5692.146178073156;5710.457506536873;5717.799877004285;3481.199324155408;3499.4051011328643;3501.63232860546;3509.666581674737;3511.2450823073164;5358.437364076716;5461.34463864323;5483.506484416422;5502.2296878436255;5540.63985840919;5299.364076310867;5306.495882891119;5329.893402132013;5380.3274590676165;5415.5126038655135;5225.216217567396;5299.894002119859;5301.23132145829;5381.650192737459;5391.865203369947;5019.598432125348;5167.328247327973;5171.586273098068;5184.507471790174;5228.085085110167;5282.524572788468;5328.973355133199;5333.7333133343955;5401.702906340189;5488.1493368527945;5292.3649162099255;5296;5303.496167864047;5355.758990845344;5403.8108666196495 19:00:51 INFO - 2015-11-11 19:00:51,887 DEBUG : BROWSER_OUTPUT: |5;yui.html;539.8488423241491;561.3544423912501;568.5707290995298;600.4415893219307;603.2128072864913;11094.833577496334;11300.547978080876;11315.886841131587;11350.20548561599;11397.886021139775;10389.584416623326;10459.477026148681;10621.73445663857;11569.305841649508;11570.132240081986;554.0940562180843;562.4375624375624;696.655155697929;712.0138608027893;720.466854527651;683.9008343790148;686.8969654551807;697.5221972948522;697.7662483068178;698.3854208296692;717.1072015340908;740.6148802622633;741.5847125609649;742.1465314887895;742.806870213743;718.1346477494607;729.1468981291902;729.4893574497846;730.0254160695451;730.7807657702695;530.4509832323565;533.0564900126793;540.124997504046;540.497337476147;541.5559241422036;11146.944265278702;11155.609553665583;11158.218924675277;11292.491837867316;11310.660680179608;7323.48735588509;7497.887531687029;7680.418263233471;7738;8338.124496927856;6921.826954326132;7108.253633368526;7164.21193668696;7188.532745371586;7212.819679508002;2402.783749462557;2429.878506074707;2456.65606815046;2487.4278915849277;2541.7077036140895;38483.23033539342;39097.60902390968;39293;39336.803315983234;39446.211075778614;5604.047311956977;5645.237892884408;5703.486686198262;5778;5874.882502350015;9926.404415735078;9946.35348702332;9949.850752238723;10066.949665251774;10094.293399461967;4773.069251495925;4795.448523419851;4817.879553011203;4874.926876096862;4899.804007839718;3063.5557844112923;3065.2796592800673;3075.8923437679573;3087.6140482439696;3096.535519672067;2163.0482587661377;2200.614892393825;2212.579609874119;2217.356966479735;2229.5206530596;313.0077653837341;315.4920577869628;316.1227593428255;318.75933670079405;322.85794250529693;408.6118187721676;419.33326011641634;430.7286409561956;466.6266986410858;496.95527402533946;5987.730552125165;6481.708323125471;6519.478441724651;6593.340665933464;6667.699953502104;467.6601536597691;470.21943573667545;492.97707257440953;499.4506043352356;500.3495455907306;2974.553816927435;3135.4826453634896;3262.706356427933;3311.122552523583;3326.5176549400203;47378.289325660146;47589;48252.27621585679;48508.27237591439;48623.5137648619;42217.57782422198;42283.36574951378;42460.150796983886;42537.14925701469;42774.57225427768;38440.03899902525;38640.673973368765;39165.608343916196;39491.80254098711;39880.800595996836;6478.870422591616;6611.867762644816;6646.235682896336;6743.325667433218;6840.384365407137;28111;28607.141785746462;28690.380032109006;29228.415431691672;29403.705962940097;34829.691179337926;34949;35911.92264232077;38186.61813381831;38494.615053849106;5970.373110823301;6122.877542449215;6243.500519958302;6301.842453938688;6440.581362211441;8379.874301885355;8798.692045778367;9216.608264198938;9330.95334523323;9383;8568.828623427622;8793.472391656522;8816.074312197383;8898.42160259581;8945.59744811498;8731.738047858575;8812.691555795516;8830.779230519289;8842.071582484004;8922.107789221025;7656.693732250647;7988;8293.543855088028;8498.362622803192;8653.826923461369;6896.965515172593;7182.328700912382;7496.7750967471065;7676.53940763556;7774.30031297186;7067.787966361017;7360.558366498028;7396.887566711093;7666.271704188316;7735.110462296908 19:00:51 INFO - 2015-11-11 19:00:51,887 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:00:51 INFO - 2015-11-11 19:00:51,887 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:00:51 INFO - 2015-11-11 19:00:51,888 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,298 19:00:51 INFO - 2015-11-11 19:00:51,888 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:00:51 INFO - 2015-11-11 19:00:51,888 DEBUG : BROWSER_OUTPUT: __startTimestamp1447297251871__endTimestamp 19:00:51 INFO - 2015-11-11 19:00:51,888 DEBUG : BROWSER_OUTPUT: 19:00:51 INFO - 2015-11-11 19:00:51,888 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:00:51 INFO - 2015-11-11 19:00:51,888 DEBUG : BROWSER_OUTPUT: Number of tests: 6 19:00:51 INFO - 2015-11-11 19:00:51,889 DEBUG : BROWSER_OUTPUT: 19:00:51 INFO - 2015-11-11 19:00:51,889 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:4487.64 Median:4616.84 stddev:583.28 (12.6%) stddev-sans-first:564.57 19:00:51 INFO - 2015-11-11 19:00:51,889 DEBUG : BROWSER_OUTPUT: Values: 2533.9 2596.9 2601.4 2650.8 2662.6 4501.5 4511.7 4541.1 4551.9 4557.7 4383.9 4454.6 4487.6 4598.2 4598.7 4196.9 4303.1 4341.3 4366.7 4375.8 366.3 4260.3 4275.6 4364.1 4411.3 4292.8 4296.0 4297.8 4334.2 4338.5 4268.4 4285.3 4315.8 4349.8 4380.0 4078.0 4173.4 4182.9 4282.1 4334.9 4300.2 4372.8 4516.0 4541.3 4607.7 4632.5 4835.9 4852.5 4868.7 4876.1 4713.7 4792.7 4799.6 4855.9 4916.4 4555.6 4556.8 4559.1 4576.6 4599.5 4759.0 4903.9 4973.5 4995.1 5037.1 4624.9 4671.5 4691.4 4718.1 4757.3 4788.0 4872.8 4874.4 4875.1 4915.9 4549.8 4616.8 4674.2 4780.9 4831.3 4786.8 4790.8 4809.0 4813.2 4859.3 3702.4 3730.1 3735.9 3753.8 3772.1 3297.3 3299.7 3355.6 3402.9 3424.9 4445.8 4515.2 4530.3 4541.9 4590.8 4872.6 4909.0 4910.8 4923.1 4964.0 4254.1 4419.9 4454.5 4495.8 4532.1 4245.0 4254.3 4274.1 4302.3 4310.0 4803.0 5041.4 5043.2 5044.6 5046.4 4785.5 4845.8 4846.5 4852.5 4896.1 5011.0 5011.5 5036.2 5039.4 5126.0 4648.9 4707.7 4793.1 4811.6 4857.6 4737.5 4820.0 4833.7 4868.9 4872.3 4751.8 4768.3 4771.4 4783.9 4804.9 4530.2 4577.1 4652.3 4725.8 4728.6 4642.0 4649.3 4656.8 4660.9 4701.4 4672.3 4681.5 4707.1 4782.0 4821.9 4437.3 4526.9 4567.0 4575.7 4680.5 19:00:51 INFO - 2015-11-11 19:00:51,889 DEBUG : BROWSER_OUTPUT: 19:00:51 INFO - 2015-11-11 19:00:51,889 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:36457.49 Median:28569.52 stddev:58498.71 (204.8%) stddev-sans-first:58600.33 19:00:51 INFO - 2015-11-11 19:00:51,891 DEBUG : BROWSER_OUTPUT: Values: 448.5 457.4 463.1 479.6 488.4 31238.8 32332.4 32535.8 32838.3 33046.9 34740.5 34746.5 34750.8 35084.6 35266.3 7350.2 7494.8 7527.6 7558.0 7637.0 7362.0 7450.9 7464.4 7542.2 7561.8 7429.2 7495.2 7503.3 7577.8 7595.3 7406.6 7485.4 7503.0 7517.6 7581.4 7466.7 7467.9 7468.5 7477.6 7575.5 32486.0 32534.3 32561.3 32943.3 32968.5 2499.4 2506.7 2596.1 2655.3 2814.5 22009.0 22667.8 23083.8 23094.9 23473.4 1880.8 1890.8 1895.5 1899.4 1910.8 212993.0 213119.0 214180.0 214981.0 215073.0 45402.5 45986.3 49755.5 51352.2 51641.7 47699.0 48079.3 48449.3 49215.0 49343.3 13401.7 13460.1 13524.5 13609.9 13624.0 10165.0 10194.3 10294.3 10322.9 10506.0 15573.5 15718.4 15785.5 15787.4 16059.9 6337.5 6500.8 6518.1 6519.9 6532.6 730.6 761.7 795.7 833.8 840.8 22832.2 22834.4 23153.2 23157.7 23327.0 809.7 814.8 853.1 869.5 872.7 12460.4 12521.2 12542.0 12778.9 12816.9 241384.0 244138.0 246325.0 247471.0 247785.0 43833.3 43895.1 43913.8 44198.6 44286.1 1111.7 1131.7 1134.1 1141.5 1142.3 23506.5 23597.8 23601.0 23806.5 23808.8 37109.0 37580.9 38020.6 38030.8 38385.5 209844.0 211857.0 212259.0 213038.0 214059.0 24760.8 25081.4 25559.1 25978.4 26130.7 32886.3 33170.3 33563.2 33599.2 33672.0 28381.8 28475.0 28574.7 28637.0 28832.3 27119.7 27496.3 27786.4 27830.5 28059.4 27635.2 27715.9 28288.2 28564.3 28604.0 24422.6 25122.7 25127.0 25625.5 25752.7 19158.7 19404.3 19526.8 19537.6 19771.0 19:00:51 INFO - 2015-11-11 19:00:51,891 DEBUG : BROWSER_OUTPUT: 19:00:51 INFO - 2015-11-11 19:00:51,891 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:18389.08 Median:4681.66 stddev:48975.13 (1046.1%) stddev-sans-first:49093.63 19:00:51 INFO - 2015-11-11 19:00:51,893 DEBUG : BROWSER_OUTPUT: Values: 274.7 275.7 276.7 277.1 287.9 11076.5 13691.5 13955.7 14084.0 14567.1 12250.9 14511.6 14803.8 15070.5 15103.6 4241.4 4278.1 4337.1 4396.7 4407.1 4303.1 4334.3 4383.7 4391.6 4402.9 3128.6 3263.5 4332.1 4359.0 4636.2 4626.4 4756.1 4832.4 4844.5 4855.0 4020.1 4120.1 4145.8 4166.1 4172.9 17279.0 17361.6 17398.2 17585.3 17674.5 1559.0 1563.3 1656.9 1702.8 1792.2 10703.0 10935.2 10969.3 11302.9 11436.1 1284.2 1318.4 1334.3 1364.6 1381.5 47063.3 47375.0 47710.8 47822.0 49404.5 7639.2 7738.4 7949.0 7955.8 8002.2 9661.8 9665.5 9667.8 9796.5 9807.8 6206.3 6335.7 6362.7 6386.0 6408.6 6349.8 6365.7 6371.2 6399.6 6414.4 4640.1 4669.6 4693.7 4710.7 4823.3 1371.5 1387.8 1388.1 1389.7 1392.6 342.5 348.1 729.4 775.3 872.8 8137.6 8319.4 8634.8 8668.1 8668.3 338.8 348.8 355.9 357.4 357.6 4591.9 4821.1 5157.8 5176.8 5318.1 292253.0 296497.0 299078.0 299243.0 300655.0 50377.0 54684.7 58608.4 59748.7 59874.4 395.6 403.9 404.7 404.9 408.9 8727.3 8876.5 8947.8 8965.4 9006.5 27444.9 27697.6 28188.6 28214.4 28356.6 37268.3 37465.4 37982.0 38070.0 38217.0 4864.2 4950.5 4964.6 5027.7 5031.2 9337.9 9409.0 9526.8 9657.6 9664.0 7992.3 8102.6 8291.8 8299.1 8379.7 7680.4 7929.9 8123.8 8217.5 8264.5 8335.9 8456.9 8614.0 8683.0 8683.6 5021.5 5088.1 5100.4 5100.4 5171.9 8175.8 8344.1 8488.1 8509.5 8588.3 19:00:51 INFO - 2015-11-11 19:00:51,893 DEBUG : BROWSER_OUTPUT: 19:00:51 INFO - 2015-11-11 19:00:51,893 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:4553.12 Median:5740.61 stddev:2375.15 (41.4%) stddev-sans-first:2370.20 19:00:51 INFO - 2015-11-11 19:00:51,893 DEBUG : BROWSER_OUTPUT: Values: 1428.6 1444.7 1460.5 1476.5 1522.4 5747.8 6061.9 6376.6 6696.3 6777.1 6323.5 6450.8 6524.0 6597.8 6616.4 1809.6 1843.6 1846.7 1866.8 1874.3 1822.3 1847.0 1858.9 1875.9 1895.5 1842.9 1870.6 1871.0 1892.6 1897.1 1756.1 1792.5 1797.1 1805.4 1818.4 1828.8 1863.4 1865.9 1877.6 1881.6 6437.3 6541.2 6577.3 6608.7 6635.4 3904.8 3931.9 3990.4 4003.9 4058.2 2118.1 2140.9 2370.7 2440.4 2470.5 724.3 743.1 745.1 748.5 755.5 8658.3 8659.4 8663.2 8762.4 8797.2 3631.4 3645.7 3681.8 3683.9 3686.0 7540.2 7553.7 7570.9 7612.7 7613.4 4030.9 4060.2 4061.2 4073.5 4128.6 3665.9 3687.9 3707.2 3729.2 3734.3 3088.9 3092.0 3126.0 3162.8 3163.6 1022.3 1036.0 1040.9 1046.7 1050.7 1066.3 1084.7 1103.0 1103.1 1112.0 6208.6 6220.2 6248.7 6277.0 6278.2 369.4 377.6 377.6 378.8 380.3 4845.8 4858.5 4867.1 4909.2 4922.3 7526.8 7821.1 7876.4 7896.3 7933.5 7744.7 7804.9 7813.8 7865.4 7869.8 5887.6 6044.2 6048.6 6164.1 6237.6 6193.0 6196.9 6228.6 6238.3 6243.0 6835.0 6926.7 6975.4 6998.6 7034.2 6844.0 7161.6 7206.6 7212.8 7279.4 5806.4 5890.1 5902.3 5908.9 5915.4 5753.7 6244.6 6355.8 6371.9 6393.1 5831.2 5858.7 5861.5 5884.6 5896.2 5733.4 5783.6 5825.1 5833.4 5843.2 5898.8 5930.2 5938.7 5949.6 5949.6 5126.8 5342.5 5397.6 5424.0 5451.6 4924.3 5035.1 5316.0 5377.7 5387.7 19:00:51 INFO - 2015-11-11 19:00:51,893 DEBUG : BROWSER_OUTPUT: 19:00:51 INFO - 2015-11-11 19:00:51,894 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:4422.95 Median:5048.31 stddev:1345.58 (26.7%) stddev-sans-first:1312.50 19:00:51 INFO - 2015-11-11 19:00:51,895 DEBUG : BROWSER_OUTPUT: Values: 255.7 261.2 261.5 261.5 265.4 4941.1 4992.0 5027.8 5046.6 5070.6 4967.3 4974.5 5005.8 5013.0 5015.6 3893.0 3906.1 3913.4 3914.1 3962.7 3880.3 3898.3 3907.7 3935.8 3958.5 3854.7 3866.5 3897.9 3898.4 3906.2 3696.1 3777.4 3795.2 3824.3 3849.4 3191.7 3197.8 3207.0 3234.5 3284.3 4827.9 4862.5 4884.4 4892.9 4910.3 4180.2 4205.6 4213.8 4222.1 4237.7 4982.2 5119.5 5119.7 5128.0 5247.5 3582.0 3586.9 3591.2 3598.3 3630.5 5318.8 5422.5 5436.1 5506.0 5518.8 3641.6 3646.8 3654.6 3662.3 3678.6 3686.9 3727.6 3760.9 3762.9 3767.8 4300.0 4311.2 4314.8 4322.1 4327.5 5214.5 5249.0 5252.1 5291.1 5318.5 1328.2 1370.0 1371.4 1373.2 1375.7 881.6 887.3 903.0 907.2 908.9 5012.8 5017.3 5026.1 5050.0 5108.0 5496.0 5536.5 5593.7 5595.2 5615.9 5023.9 5027.0 5052.1 5105.6 5131.5 2967.6 3029.9 3058.2 3097.1 3103.9 5643.0 5671.7 5673.7 5725.5 5736.1 5632.5 5679.4 5713.1 5717.7 5719.3 5659.3 5683.2 5698.3 5736.4 5744.9 5268.2 5367.0 5369.8 5463.9 5518.4 5309.1 5361.9 5401.1 5419.8 5424.9 5507.9 5645.5 5692.1 5710.5 5717.8 3481.2 3499.4 3501.6 3509.7 3511.2 5358.4 5461.3 5483.5 5502.2 5540.6 5299.4 5306.5 5329.9 5380.3 5415.5 5225.2 5299.9 5301.2 5381.7 5391.9 5019.6 5167.3 5171.6 5184.5 5228.1 5282.5 5329.0 5333.7 5401.7 5488.1 5292.4 5296.0 5303.5 5355.8 5403.8 19:00:51 INFO - 2015-11-11 19:00:51,895 DEBUG : BROWSER_OUTPUT: 19:00:51 INFO - 2015-11-11 19:00:51,896 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:10778.92 Median:540.31 stddev:13338.04 (2468.6%) stddev-sans-first:13353.30 19:00:51 INFO - 2015-11-11 19:00:51,896 DEBUG : BROWSER_OUTPUT: Values: 539.8 561.4 568.6 600.4 603.2 11094.8 11300.5 11315.9 11350.2 11397.9 10389.6 10459.5 10621.7 11569.3 11570.1 554.1 562.4 696.7 712.0 720.5 683.9 686.9 697.5 697.8 698.4 717.1 740.6 741.6 742.1 742.8 718.1 729.1 729.5 730.0 730.8 530.5 533.1 540.1 540.5 541.6 11146.9 11155.6 11158.2 11292.5 11310.7 7323.5 7497.9 7680.4 7738.0 8338.1 6921.8 7108.3 7164.2 7188.5 7212.8 2402.8 2429.9 2456.7 2487.4 2541.7 38483.2 39097.6 39293.0 39336.8 39446.2 5604.0 5645.2 5703.5 5778.0 5874.9 9926.4 9946.4 9949.9 10066.9 10094.3 4773.1 4795.4 4817.9 4874.9 4899.8 3063.6 3065.3 3075.9 3087.6 3096.5 2163.0 2200.6 2212.6 2217.4 2229.5 313.0 315.5 316.1 318.8 322.9 408.6 419.3 430.7 466.6 497.0 5987.7 6481.7 6519.5 6593.3 6667.7 467.7 470.2 493.0 499.5 500.3 2974.6 3135.5 3262.7 3311.1 3326.5 47378.3 47589.0 48252.3 48508.3 48623.5 42217.6 42283.4 42460.2 42537.1 42774.6 38440.0 38640.7 39165.6 39491.8 39880.8 6478.9 6611.9 6646.2 6743.3 6840.4 28111.0 28607.1 28690.4 29228.4 29403.7 34829.7 34949.0 35911.9 38186.6 38494.6 5970.4 6122.9 6243.5 6301.8 6440.6 8379.9 8798.7 9216.6 9331.0 9383.0 8568.8 8793.5 8816.1 8898.4 8945.6 8731.7 8812.7 8830.8 8842.1 8922.1 7656.7 7988.0 8293.5 8498.4 8653.8 6897.0 7182.3 7496.8 7676.5 7774.3 7067.8 7360.6 7396.9 7666.3 7735.1 19:00:51 INFO - 2015-11-11 19:00:51,897 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:00:51 INFO - 2015-11-11 19:00:51,897 DEBUG : BROWSER_OUTPUT: 19:00:52 INFO - 2015-11-11 19:00:52,585 INFO : Browser exited with error code: 0 19:00:52 INFO - 2015-11-11 19:00:52,620 INFO : Completed test dromaeo_css (00:18:33) 19:00:52 INFO - 2015-11-11 19:00:52,620 INFO : Starting test kraken 19:00:52 INFO - 2015-11-11 19:00:52,620 DEBUG : operating with platform_type : mac_ 19:00:52 INFO - 2015-11-11 19:00:52,620 INFO : Initialising browser for kraken test... 19:00:52 INFO - 2015-11-11 19:00:52,636 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmp5Rfyed/profile http://localhost:49275/getInfo.html 19:00:56 INFO - 2015-11-11 19:00:56,129 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:00:56 INFO - 2015-11-11 19:00:56,129 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:00:56 INFO - 2015-11-11 19:00:56,129 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:00:56 INFO - 2015-11-11 19:00:56,129 DEBUG : BROWSER_OUTPUT: __metrics 19:00:56 INFO - 2015-11-11 19:00:56,884 INFO : Browser initialized. 19:00:56 INFO - 2015-11-11 19:00:56,884 INFO : Running cycle 1/1 for kraken test... 19:00:56 INFO - 2015-11-11 19:00:56,885 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmp5Rfyed/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:01:09 INFO - 2015-11-11 19:01:09,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 239861760 19:01:09 INFO - 2015-11-11 19:01:09,330 DEBUG : BROWSER_OUTPUT: 19:01:12 INFO - 2015-11-11 19:01:12,302 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection) 19:01:12 INFO - 2015-11-11 19:01:12,908 DEBUG : BROWSER_OUTPUT: RSS: Main: 259440640 19:01:12 INFO - 2015-11-11 19:01:12,908 DEBUG : BROWSER_OUTPUT: 19:01:16 INFO - 2015-11-11 19:01:16,063 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-dft) 19:01:16 INFO - 2015-11-11 19:01:16,671 DEBUG : BROWSER_OUTPUT: RSS: Main: 266702848 19:01:16 INFO - 2015-11-11 19:01:16,671 DEBUG : BROWSER_OUTPUT: 19:01:20 INFO - 2015-11-11 19:01:20,075 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-fft) 19:01:20 INFO - 2015-11-11 19:01:20,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 267710464 19:01:20 INFO - 2015-11-11 19:01:20,657 DEBUG : BROWSER_OUTPUT: 19:01:22 INFO - 2015-11-11 19:01:22,911 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator) 19:01:23 INFO - 2015-11-11 19:01:23,518 DEBUG : BROWSER_OUTPUT: RSS: Main: 268029952 19:01:23 INFO - 2015-11-11 19:01:23,518 DEBUG : BROWSER_OUTPUT: 19:01:25 INFO - 2015-11-11 19:01:25,945 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur) 19:01:26 INFO - 2015-11-11 19:01:26,532 DEBUG : BROWSER_OUTPUT: RSS: Main: 268197888 19:01:26 INFO - 2015-11-11 19:01:26,532 DEBUG : BROWSER_OUTPUT: 19:01:30 INFO - 2015-11-11 19:01:30,121 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom) 19:01:30 INFO - 2015-11-11 19:01:30,728 DEBUG : BROWSER_OUTPUT: RSS: Main: 267116544 19:01:30 INFO - 2015-11-11 19:01:30,728 DEBUG : BROWSER_OUTPUT: 19:01:34 INFO - 2015-11-11 19:01:34,448 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate) 19:01:35 INFO - 2015-11-11 19:01:35,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 265371648 19:01:35 INFO - 2015-11-11 19:01:35,054 DEBUG : BROWSER_OUTPUT: 19:01:38 INFO - 2015-11-11 19:01:38,469 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial) 19:01:39 INFO - 2015-11-11 19:01:39,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 267546624 19:01:39 INFO - 2015-11-11 19:01:39,057 DEBUG : BROWSER_OUTPUT: 19:01:40 INFO - 2015-11-11 19:01:40,866 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox) 19:01:41 INFO - 2015-11-11 19:01:41,456 DEBUG : BROWSER_OUTPUT: RSS: Main: 267870208 19:01:41 INFO - 2015-11-11 19:01:41,456 DEBUG : BROWSER_OUTPUT: 19:01:43 INFO - 2015-11-11 19:01:43,515 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes) 19:01:44 INFO - 2015-11-11 19:01:44,149 DEBUG : BROWSER_OUTPUT: RSS: Main: 267276288 19:01:44 INFO - 2015-11-11 19:01:44,149 DEBUG : BROWSER_OUTPUT: 19:01:46 INFO - 2015-11-11 19:01:46,563 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm) 19:01:47 INFO - 2015-11-11 19:01:47,163 DEBUG : BROWSER_OUTPUT: RSS: Main: 267341824 19:01:47 INFO - 2015-11-11 19:01:47,163 DEBUG : BROWSER_OUTPUT: 19:01:50 INFO - 2015-11-11 19:01:50,202 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 19:01:50 INFO - 2015-11-11 19:01:50,807 DEBUG : BROWSER_OUTPUT: RSS: Main: 267698176 19:01:50 INFO - 2015-11-11 19:01:50,807 DEBUG : BROWSER_OUTPUT: 19:01:53 INFO - 2015-11-11 19:01:53,923 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 19:01:54 INFO - 2015-11-11 19:01:54,514 DEBUG : BROWSER_OUTPUT: RSS: Main: 267902976 19:01:54 INFO - 2015-11-11 19:01:54,514 DEBUG : BROWSER_OUTPUT: 19:01:56 INFO - 2015-11-11 19:01:56,478 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49275/tests/kraken/driver.html?testName=ai-astar) 19:01:56 INFO - 2015-11-11 19:01:56,736 DEBUG : BROWSER_OUTPUT: RSS: Main: 269045760 19:01:56 INFO - 2015-11-11 19:01:56,736 DEBUG : BROWSER_OUTPUT: 19:01:56 INFO - 2015-11-11 19:01:56,736 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:01:56 INFO - 2015-11-11 19:01:56,736 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:01:56 INFO - 2015-11-11 19:01:56,736 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:01:56 INFO - 2015-11-11 19:01:56,737 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:01:56 INFO - 2015-11-11 19:01:56,737 DEBUG : BROWSER_OUTPUT: |0;ai-astar;133;130;143;141;138;144;134;140;140;142 19:01:56 INFO - 2015-11-11 19:01:56,737 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;192;170;200;211;169;187;188;164;196;167 19:01:56 INFO - 2015-11-11 19:01:56,737 DEBUG : BROWSER_OUTPUT: |2;audio-dft;214;207;209;201;202;204;211;210;204;201 19:01:56 INFO - 2015-11-11 19:01:56,737 DEBUG : BROWSER_OUTPUT: |3;audio-fft;86;97;103;150;84;86;92;88;124;81 19:01:56 INFO - 2015-11-11 19:01:56,737 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;108;109;157;112;114;114;151;108;109;154 19:01:56 INFO - 2015-11-11 19:01:56,738 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;157;150;152;150;157;156;143;151;157;147 19:01:56 INFO - 2015-11-11 19:01:56,738 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;163;164;162;156;164;166;156;164;166;161 19:01:56 INFO - 2015-11-11 19:01:56,738 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;127;138;137;136;133;134;134;135;132;133 19:01:56 INFO - 2015-11-11 19:01:56,738 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;73;76;80;82;83;82;83;89;80;81 19:01:56 INFO - 2015-11-11 19:01:56,738 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;83;85;88;88;86;87;87;83;84;83 19:01:56 INFO - 2015-11-11 19:01:56,739 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;108;113;112;112;114;114;113;108;109;115 19:01:56 INFO - 2015-11-11 19:01:56,739 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;161;168;162;172;160;171;168;164;165;164 19:01:56 INFO - 2015-11-11 19:01:56,739 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;180;205;206;203;196;196;202;202;201;192 19:01:56 INFO - 2015-11-11 19:01:56,739 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;83;89;89;96;95;93;93;93;95;93 19:01:56 INFO - 2015-11-11 19:01:56,739 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:01:56 INFO - 2015-11-11 19:01:56,740 DEBUG : BROWSER_OUTPUT: __start_cc_report 19:01:56 INFO - 2015-11-11 19:01:56,740 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,757 19:01:56 INFO - 2015-11-11 19:01:56,740 DEBUG : BROWSER_OUTPUT: __end_cc_report 19:01:56 INFO - 2015-11-11 19:01:56,740 DEBUG : BROWSER_OUTPUT: __startTimestamp1447297316730__endTimestamp 19:01:56 INFO - 2015-11-11 19:01:56,740 DEBUG : BROWSER_OUTPUT: 19:01:56 INFO - 2015-11-11 19:01:56,740 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:01:56 INFO - 2015-11-11 19:01:56,741 DEBUG : BROWSER_OUTPUT: Number of tests: 14 19:01:56 INFO - 2015-11-11 19:01:56,741 DEBUG : BROWSER_OUTPUT: 19:01:56 INFO - 2015-11-11 19:01:56,741 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:138.50 Median:140.50 stddev:4.67 (3.3%) stddev-sans-first:4.51 19:01:56 INFO - 2015-11-11 19:01:56,741 DEBUG : BROWSER_OUTPUT: Values: 133.0 130.0 143.0 141.0 138.0 144.0 134.0 140.0 140.0 142.0 19:01:56 INFO - 2015-11-11 19:01:56,741 DEBUG : BROWSER_OUTPUT: 19:01:56 INFO - 2015-11-11 19:01:56,741 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:184.40 Median:190.00 stddev:16.08 (8.5%) stddev-sans-first:16.82 19:01:56 INFO - 2015-11-11 19:01:56,741 DEBUG : BROWSER_OUTPUT: Values: 192.0 170.0 200.0 211.0 169.0 187.0 188.0 164.0 196.0 167.0 19:01:56 INFO - 2015-11-11 19:01:56,742 DEBUG : BROWSER_OUTPUT: 19:01:56 INFO - 2015-11-11 19:01:56,742 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:206.30 Median:208.00 stddev:4.57 (2.2%) stddev-sans-first:3.91 19:01:56 INFO - 2015-11-11 19:01:56,742 DEBUG : BROWSER_OUTPUT: Values: 214.0 207.0 209.0 201.0 202.0 204.0 211.0 210.0 204.0 201.0 19:01:56 INFO - 2015-11-11 19:01:56,742 DEBUG : BROWSER_OUTPUT: 19:01:56 INFO - 2015-11-11 19:01:56,742 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:99.10 Median:86.00 stddev:21.87 (25.4%) stddev-sans-first:22.67 19:01:56 INFO - 2015-11-11 19:01:56,742 DEBUG : BROWSER_OUTPUT: Values: 86.0 97.0 103.0 150.0 84.0 86.0 92.0 88.0 124.0 81.0 19:01:56 INFO - 2015-11-11 19:01:56,742 DEBUG : BROWSER_OUTPUT: 19:01:56 INFO - 2015-11-11 19:01:56,743 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:123.60 Median:114.00 stddev:21.14 (18.5%) stddev-sans-first:21.66 19:01:56 INFO - 2015-11-11 19:01:56,743 DEBUG : BROWSER_OUTPUT: Values: 108.0 109.0 157.0 112.0 114.0 114.0 151.0 108.0 109.0 154.0 19:01:56 INFO - 2015-11-11 19:01:56,743 DEBUG : BROWSER_OUTPUT: 19:01:56 INFO - 2015-11-11 19:01:56,743 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:152.00 Median:154.00 stddev:4.78 (3.1%) stddev-sans-first:4.72 19:01:56 INFO - 2015-11-11 19:01:56,743 DEBUG : BROWSER_OUTPUT: Values: 157.0 150.0 152.0 150.0 157.0 156.0 143.0 151.0 157.0 147.0 19:01:56 INFO - 2015-11-11 19:01:56,743 DEBUG : BROWSER_OUTPUT: 19:01:56 INFO - 2015-11-11 19:01:56,744 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:162.20 Median:164.00 stddev:3.61 (2.2%) stddev-sans-first:3.82 19:01:56 INFO - 2015-11-11 19:01:56,744 DEBUG : BROWSER_OUTPUT: Values: 163.0 164.0 162.0 156.0 164.0 166.0 156.0 164.0 166.0 161.0 19:01:56 INFO - 2015-11-11 19:01:56,744 DEBUG : BROWSER_OUTPUT: 19:01:56 INFO - 2015-11-11 19:01:56,744 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:133.90 Median:134.50 stddev:3.07 (2.3%) stddev-sans-first:2.00 19:01:56 INFO - 2015-11-11 19:01:56,744 DEBUG : BROWSER_OUTPUT: Values: 127.0 138.0 137.0 136.0 133.0 134.0 134.0 135.0 132.0 133.0 19:01:56 INFO - 2015-11-11 19:01:56,744 DEBUG : BROWSER_OUTPUT: 19:01:56 INFO - 2015-11-11 19:01:56,745 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:80.90 Median:82.00 stddev:4.28 (5.2%) stddev-sans-first:3.46 19:01:56 INFO - 2015-11-11 19:01:56,745 DEBUG : BROWSER_OUTPUT: Values: 73.0 76.0 80.0 82.0 83.0 82.0 83.0 89.0 80.0 81.0 19:01:56 INFO - 2015-11-11 19:01:56,745 DEBUG : BROWSER_OUTPUT: 19:01:56 INFO - 2015-11-11 19:01:56,745 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:85.40 Median:86.50 stddev:2.07 (2.4%) stddev-sans-first:2.00 19:01:56 INFO - 2015-11-11 19:01:56,745 DEBUG : BROWSER_OUTPUT: Values: 83.0 85.0 88.0 88.0 86.0 87.0 87.0 83.0 84.0 83.0 19:01:56 INFO - 2015-11-11 19:01:56,745 DEBUG : BROWSER_OUTPUT: 19:01:56 INFO - 2015-11-11 19:01:56,745 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:111.80 Median:113.00 stddev:2.57 (2.3%) stddev-sans-first:2.33 19:01:56 INFO - 2015-11-11 19:01:56,745 DEBUG : BROWSER_OUTPUT: Values: 108.0 113.0 112.0 112.0 114.0 114.0 113.0 108.0 109.0 115.0 19:01:56 INFO - 2015-11-11 19:01:56,746 DEBUG : BROWSER_OUTPUT: 19:01:56 INFO - 2015-11-11 19:01:56,746 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:165.50 Median:166.50 stddev:4.12 (2.5%) stddev-sans-first:4.03 19:01:56 INFO - 2015-11-11 19:01:56,746 DEBUG : BROWSER_OUTPUT: Values: 161.0 168.0 162.0 172.0 160.0 171.0 168.0 164.0 165.0 164.0 19:01:56 INFO - 2015-11-11 19:01:56,746 DEBUG : BROWSER_OUTPUT: 19:01:56 INFO - 2015-11-11 19:01:56,746 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:198.30 Median:202.00 stddev:7.79 (3.9%) stddev-sans-first:4.66 19:01:56 INFO - 2015-11-11 19:01:56,746 DEBUG : BROWSER_OUTPUT: Values: 180.0 205.0 206.0 203.0 196.0 196.0 202.0 202.0 201.0 192.0 19:01:56 INFO - 2015-11-11 19:01:56,748 DEBUG : BROWSER_OUTPUT: 19:01:56 INFO - 2015-11-11 19:01:56,748 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:91.90 Median:93.00 stddev:3.90 (4.2%) stddev-sans-first:2.47 19:01:56 INFO - 2015-11-11 19:01:56,748 DEBUG : BROWSER_OUTPUT: Values: 83.0 89.0 89.0 96.0 95.0 93.0 93.0 93.0 95.0 93.0 19:01:56 INFO - 2015-11-11 19:01:56,748 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:01:56 INFO - 2015-11-11 19:01:56,748 DEBUG : BROWSER_OUTPUT: 19:01:57 INFO - 2015-11-11 19:01:57,502 INFO : Browser exited with error code: 0 19:01:57 INFO - 2015-11-11 19:01:57,559 INFO : Completed test kraken (00:01:04) 19:01:57 INFO - 2015-11-11 19:01:57,559 INFO : Starting test v8_7 19:01:57 INFO - 2015-11-11 19:01:57,559 DEBUG : operating with platform_type : mac_ 19:01:57 INFO - 2015-11-11 19:01:57,559 INFO : Initialising browser for v8_7 test... 19:01:57 INFO - 2015-11-11 19:01:57,574 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpgQR2Oy/profile http://localhost:49275/getInfo.html 19:02:00 INFO - 2015-11-11 19:02:00,987 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 19:02:00 INFO - 2015-11-11 19:02:00,988 DEBUG : BROWSER_OUTPUT: colorDepth:24 19:02:00 INFO - 2015-11-11 19:02:00,988 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 19:02:00 INFO - 2015-11-11 19:02:00,988 DEBUG : BROWSER_OUTPUT: __metrics 19:02:01 INFO - 2015-11-11 19:02:01,707 INFO : Browser initialized. 19:02:01 INFO - 2015-11-11 19:02:01,708 INFO : Running cycle 1/1 for v8_7 test... 19:02:01 INFO - 2015-11-11 19:02:01,708 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/T/tmpgQR2Oy/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 19:02:14 INFO - 2015-11-11 19:02:14,102 DEBUG : BROWSER_OUTPUT: RSS: Main: 241389568 19:02:14 INFO - 2015-11-11 19:02:14,103 DEBUG : BROWSER_OUTPUT: 19:02:36 INFO - 2015-11-11 19:02:36,759 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49275/tests/v8_7/run.html (next: http://localhost:49275/tests/v8_7/run.html) 19:02:37 INFO - 2015-11-11 19:02:37,020 DEBUG : BROWSER_OUTPUT: RSS: Main: 261144576 19:02:37 INFO - 2015-11-11 19:02:37,020 DEBUG : BROWSER_OUTPUT: 19:02:37 INFO - 2015-11-11 19:02:37,020 DEBUG : BROWSER_OUTPUT: __start_tp_report 19:02:37 INFO - 2015-11-11 19:02:37,021 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 19:02:37 INFO - 2015-11-11 19:02:37,022 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 19:02:37 INFO - 2015-11-11 19:02:37,023 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 19:02:37 INFO - 2015-11-11 19:02:37,023 DEBUG : BROWSER_OUTPUT: |0;Richards;901.7132551848512 19:02:37 INFO - 2015-11-11 19:02:37,023 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;243.66471734892787 19:02:37 INFO - 2015-11-11 19:02:37,023 DEBUG : BROWSER_OUTPUT: |2;Encrypt;387.8975950349108 19:02:37 INFO - 2015-11-11 19:02:37,023 DEBUG : BROWSER_OUTPUT: |3;Decrypt;7049.295774647887 19:02:37 INFO - 2015-11-11 19:02:37,023 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1400.5602240896358 19:02:37 INFO - 2015-11-11 19:02:37,023 DEBUG : BROWSER_OUTPUT: |5;Earley;964.3201542912246 19:02:37 INFO - 2015-11-11 19:02:37,023 DEBUG : BROWSER_OUTPUT: |6;Boyer;15936.507936507936 19:02:37 INFO - 2015-11-11 19:02:37,024 DEBUG : BROWSER_OUTPUT: |7;RegExp;35210.52631578947 19:02:37 INFO - 2015-11-11 19:02:37,024 DEBUG : BROWSER_OUTPUT: |8;Splay;843.8818565400844 19:02:37 INFO - 2015-11-11 19:02:37,024 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;7244.604316546763 19:02:37 INFO - 2015-11-11 19:02:37,024 DEBUG : BROWSER_OUTPUT: __end_tp_report 19:02:37 INFO - 2015-11-11 19:02:37,024 DEBUG : BROWSER_OUTPUT: __startTimestamp1447297357020__endTimestamp 19:02:37 INFO - 2015-11-11 19:02:37,024 DEBUG : BROWSER_OUTPUT: 19:02:37 INFO - 2015-11-11 19:02:37,024 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 19:02:37 INFO - 2015-11-11 19:02:37,025 DEBUG : BROWSER_OUTPUT: Number of tests: 10 19:02:37 INFO - 2015-11-11 19:02:37,025 DEBUG : BROWSER_OUTPUT: 19:02:37 INFO - 2015-11-11 19:02:37,025 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:901.71 Median:901.71 stddev:0.00 (0.0%) 19:02:37 INFO - 2015-11-11 19:02:37,025 DEBUG : BROWSER_OUTPUT: Values: 901.7 19:02:37 INFO - 2015-11-11 19:02:37,025 DEBUG : BROWSER_OUTPUT: 19:02:37 INFO - 2015-11-11 19:02:37,025 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:243.66 Median:243.66 stddev:0.00 (0.0%) 19:02:37 INFO - 2015-11-11 19:02:37,025 DEBUG : BROWSER_OUTPUT: Values: 243.7 19:02:37 INFO - 2015-11-11 19:02:37,025 DEBUG : BROWSER_OUTPUT: 19:02:37 INFO - 2015-11-11 19:02:37,026 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:387.90 Median:387.90 stddev:0.00 (0.0%) 19:02:37 INFO - 2015-11-11 19:02:37,026 DEBUG : BROWSER_OUTPUT: Values: 387.9 19:02:37 INFO - 2015-11-11 19:02:37,026 DEBUG : BROWSER_OUTPUT: 19:02:37 INFO - 2015-11-11 19:02:37,026 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:7049.30 Median:7049.30 stddev:0.00 (0.0%) 19:02:37 INFO - 2015-11-11 19:02:37,026 DEBUG : BROWSER_OUTPUT: Values: 7049.3 19:02:37 INFO - 2015-11-11 19:02:37,026 DEBUG : BROWSER_OUTPUT: 19:02:37 INFO - 2015-11-11 19:02:37,026 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1400.56 Median:1400.56 stddev:0.00 (0.0%) 19:02:37 INFO - 2015-11-11 19:02:37,026 DEBUG : BROWSER_OUTPUT: Values: 1400.6 19:02:37 INFO - 2015-11-11 19:02:37,026 DEBUG : BROWSER_OUTPUT: 19:02:37 INFO - 2015-11-11 19:02:37,027 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:964.32 Median:964.32 stddev:0.00 (0.0%) 19:02:37 INFO - 2015-11-11 19:02:37,027 DEBUG : BROWSER_OUTPUT: Values: 964.3 19:02:37 INFO - 2015-11-11 19:02:37,027 DEBUG : BROWSER_OUTPUT: 19:02:37 INFO - 2015-11-11 19:02:37,027 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:15936.51 Median:15936.51 stddev:0.00 (0.0%) 19:02:37 INFO - 2015-11-11 19:02:37,027 DEBUG : BROWSER_OUTPUT: Values: 15936.5 19:02:37 INFO - 2015-11-11 19:02:37,027 DEBUG : BROWSER_OUTPUT: 19:02:37 INFO - 2015-11-11 19:02:37,027 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:35210.53 Median:35210.53 stddev:0.00 (0.0%) 19:02:37 INFO - 2015-11-11 19:02:37,027 DEBUG : BROWSER_OUTPUT: Values: 35210.5 19:02:37 INFO - 2015-11-11 19:02:37,027 DEBUG : BROWSER_OUTPUT: 19:02:37 INFO - 2015-11-11 19:02:37,028 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:843.88 Median:843.88 stddev:0.00 (0.0%) 19:02:37 INFO - 2015-11-11 19:02:37,028 DEBUG : BROWSER_OUTPUT: Values: 843.9 19:02:37 INFO - 2015-11-11 19:02:37,028 DEBUG : BROWSER_OUTPUT: 19:02:37 INFO - 2015-11-11 19:02:37,028 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:7244.60 Median:7244.60 stddev:0.00 (0.0%) 19:02:37 INFO - 2015-11-11 19:02:37,028 DEBUG : BROWSER_OUTPUT: Values: 7244.6 19:02:37 INFO - 2015-11-11 19:02:37,028 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 19:02:37 INFO - 2015-11-11 19:02:37,028 DEBUG : BROWSER_OUTPUT: 19:02:37 INFO - 2015-11-11 19:02:37,758 INFO : Browser exited with error code: 0 19:02:37 INFO - 2015-11-11 19:02:37,783 INFO : Completed test v8_7 (00:00:40) 19:02:37 INFO - 2015-11-11 19:02:37,901 INFO : Completed test suite (00:20:19) 19:02:37 INFO - 2015-11-11 19:02:37,901 DEBUG : Working with test: dromaeo_css 19:02:37 INFO - 2015-11-11 19:02:37,901 DEBUG : Generating results file: dromaeo_css 19:02:37 INFO - 2015-11-11 19:02:37,902 DEBUG : Working with test: kraken 19:02:37 INFO - 2015-11-11 19:02:37,902 DEBUG : Generating results file: kraken 19:02:37 INFO - 2015-11-11 19:02:37,902 INFO : javascript benchmark 19:02:37 INFO - 2015-11-11 19:02:37,902 DEBUG : Working with test: v8_7 19:02:37 INFO - 2015-11-11 19:02:37,902 DEBUG : Generating results file: v8_7 19:02:37 INFO - 2015-11-11 19:02:37,903 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:02:37 INFO - 2015-11-11 19:02:37,951 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,57]] 19:02:37 INFO - 2015-11-11 19:02:37,951 DEBUG : process_Request line: dromaeo_css 5503.25 graph.html#tests=[[72,1,57]] 19:02:37 INFO - 2015-11-11 19:02:37,951 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:02:37 INFO - 2015-11-11 19:02:37,984 DEBUG : process_Request line: kraken 1933.80 graph.html#tests=[[232,1,57]] 19:02:37 INFO - 2015-11-11 19:02:37,984 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 19:02:38 INFO - 2015-11-11 19:02:38,016 DEBUG : process_Request line: v8_7 13678.45 graph.html#tests=[[230,1,57]] 19:02:38 INFO - 2015-11-11 19:02:38,017 INFO : javascript benchmark 19:02:38 INFO - 2015-11-11 19:02:38,019 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [274.7197858184653, 275.6939796825523, 276.69010708007033, 277.0787132783494, 287.9222609895328, 11076.501557429914, 13691.452341906324, 13955.720885582283, 14084.0, 14567.125972441661, 12250.93874530626, 14511.637209069779, 14803.777943330831, 15070.47253346133, 15103.62240943977, 4241.384999175118, 4278.058827058042, 4337.110892267094, 4396.714213576107, 4407.07451435199, 4303.117860838521, 4334.306510958248, 4383.693141480097, 4391.5608439155985, 4402.889927751816, 3128.593282873235, 3263.543103965435, 4332.111917057012, 4358.956410435887, 4636.165490211761, 4626.398568186114, 4756.143894099061, 4832.444268909086, 4844.467108618049, 4854.951450485503, 4020.1356708307853, 4120.072983578671, 4145.813438395249, 4166.1251137261215, 4172.937405938914, 17279.0, 17361.565960850952, 17398.21708023142, 17585.296588136458, 17674.469765907044, 1558.9688206235812, 1563.3433957737777, 1656.9337226510925, 1702.825050715015, 1792.1935129191786, 10703.0, 10935.179861510418, 10969.341839489576, 11302.886971130265, 11436.142289328334, 1284.2166278570064, 1318.3605951113702, 1334.252818421687, 1364.624728199743, 1381.5371850430117, 47063.29405058927, 47375.0, 47710.76144619255, 47822.0, 49404.50595494071, 7639.236076392316, 7738.380929525624, 7949.046114466301, 7955.801104972306, 8002.239787220205, 9661.806763864683, 9665.468399238109, 9667.806643867083, 9796.461194634363, 9807.803843923082, 6206.286277078194, 6335.714892829834, 6362.6818659067785, 6386.0, 6408.61548307103, 6349.825282322785, 6365.681715914186, 6371.23545174582, 6399.584027038228, 6414.422701956753, 4640.071985602893, 4669.649776266793, 4693.671442998957, 4710.6702530823195, 4823.324734537167, 1371.4925477573163, 1387.7918312253244, 1388.1046724862408, 1389.6525868532867, 1392.6239915222834, 342.4982400782865, 348.0640794895068, 729.4383324839949, 775.2673723331397, 872.7643536245179, 8137.5931203439595, 8319.417640765088, 8634.827303453896, 8668.133186681407, 8668.306535477146, 338.7933360650002, 348.8238439588043, 355.9252556963015, 357.44952772730227, 357.613777120709, 4591.9081618367445, 4821.108095002365, 5157.819476318311, 5176.792928282902, 5318.069337865858, 292253.0, 296497.0, 299078.0, 299243.0, 300655.0, 50377.0, 54684.72657636686, 58608.41391586115, 59748.70125649344, 59874.40125598775, 395.6281095769967, 403.8808551477321, 404.66210714054097, 404.9128091075413, 408.94479245302097, 8727.258183054511, 8876.51179185151, 8947.821043579223, 8965.372423930263, 9006.50464224474, 27444.862775685993, 27697.58453623157, 28188.577171342036, 28214.43571128607, 28356.574651379833, 37268.254634907695, 37465.4380184292, 37982.0, 38070.0, 38217.0, 4864.221724524059, 4950.504949505021, 4964.578010869117, 5027.7234752087525, 5031.169856973558, 9337.906620933976, 9409.0, 9526.809463810823, 9657.613695452103, 9663.951680241555, 7992.280694737501, 8102.554359510284, 8291.83416331658, 8299.128591498047, 8379.748607541784, 7680.423968202295, 7929.920700792918, 8123.7969050771835, 8217.534739578223, 8264.462809917337, 8335.874961875455, 8456.915430845613, 8613.95693021556, 8682.956585217033, 8683.609237584451, 5021.497850215095, 5088.135017047185, 5100.38795344561, 5100.413452453015, 5171.92242116361, 8175.836483270183, 8344.123866993878, 8488.066312705474, 8509.489430634181, 8588.312934965063], "dojo.html": [2533.885975131119, 2596.9350766230846, 2601.3626661467933, 2650.8409495430265, 2662.6405435266256, 4501.527339629337, 4511.706739061959, 4541.069080838429, 4551.908961820762, 4557.703749256296, 4383.890402739933, 4454.594518959758, 4487.596116349528, 4598.172328980782, 4598.70108442951, 4196.874093777192, 4303.074838909633, 4341.261985462479, 4366.716163449381, 4375.7593332366705, 366.32288487408334, 4260.339647354665, 4275.636570891478, 4364.061726728753, 4411.27214009688, 4292.828286868522, 4295.978520107379, 4297.785110744481, 4334.176506463762, 4338.522762496123, 4268.445102136733, 4285.250081235771, 4315.805788739514, 4349.84775532858, 4379.956200438019, 4078.0416602098485, 4173.373993900909, 4182.853600124012, 4282.057947251599, 4334.891627709301, 4300.182965236626, 4372.803223854934, 4515.96132889434, 4541.296099104644, 4607.677462577621, 4632.490426053131, 4835.927461088087, 4852.514748525155, 4868.659193856396, 4876.073546026244, 4713.717176969359, 4792.688475249098, 4799.568038876483, 4855.878603034917, 4916.434610019822, 4555.612772914339, 4556.817727290938, 4559.110973360163, 4576.565226303529, 4599.540045995407, 4759.0, 4903.8966232598095, 4973.502649734997, 4995.100881841231, 5037.0681423936685, 4624.907501849944, 4671.509491503343, 4691.437027556715, 4718.127146477913, 4757.26262429324, 4787.994521150597, 4872.829450969199, 4874.390701162355, 4875.07373599015, 4915.877103072452, 4549.772511374418, 4616.838410655611, 4674.158651442773, 4780.856574302707, 4831.275308703723, 4786.8085276588545, 4790.784414701347, 4809.014152098812, 4813.229883218738, 4859.2954021667365, 3702.444633305026, 3730.086128898383, 3735.916584190609, 3753.7935413551972, 3772.1135533149686, 3297.274599588087, 3299.736021118305, 3355.647656996029, 3402.914927126792, 3424.9143771405415, 4445.755483448442, 4515.228716298416, 4530.320451932236, 4541.931871021938, 4590.816367345269, 4872.634552408584, 4908.950910490921, 4910.8281210157475, 4923.08922849274, 4964.007198560303, 4254.106637606137, 4419.9337009944875, 4454.465464144323, 4495.752733599684, 4532.093581283756, 4244.978775106105, 4254.255505286563, 4274.123804620045, 4302.290122129876, 4309.978450107729, 4803.0, 5041.420236672683, 5043.193089105725, 5044.596432285482, 5046.39443266803, 4785.473597904158, 4845.781939812788, 4846.539578740014, 4852.539008794159, 4896.069746748107, 5011.047900898818, 5011.473795251446, 5036.169032109661, 5039.420466646383, 5126.0, 4648.883777905444, 4707.693999889996, 4793.089313030513, 4811.639127065554, 4857.562819346276, 4737.478877323423, 4820.0, 4833.685810422311, 4868.902621947612, 4872.293517440023, 4751.809927602857, 4768.308595253599, 4771.427428708438, 4783.928241076456, 4804.927926081042, 4530.184566778012, 4577.0845830833305, 4652.255639097863, 4725.834595789131, 4728.550787675165, 4641.976790116028, 4649.279361698942, 4656.8137274508645, 4660.883477912944, 4701.388819453449, 4672.252439609646, 4681.461631912373, 4707.105649926503, 4781.952180478151, 4821.879453013703, 4437.312216606431, 4526.909461810811, 4566.954330456653, 4575.7483338416705, 4680.5085466025575], "mootools.html": [1428.6214153249387, 1444.6677264229234, 1460.4523303761096, 1476.5496523560316, 1522.4062615579926, 5747.827565173052, 6061.87876242476, 6376.649284289368, 6696.263411024789, 6777.085093512381, 6323.462505687022, 6450.7742229022, 6523.967380163104, 6597.769078082268, 6616.437602803768, 1809.6018875847326, 1843.612841303328, 1846.7414561961336, 1866.8413184879234, 1874.3252429125505, 1822.3439561757757, 1846.9630607387844, 1858.8977606231651, 1875.8968256745873, 1895.469268604793, 1842.9262829486804, 1870.6071724937779, 1871.0270659257178, 1892.6120145370166, 1897.0704354866086, 1756.0868348458794, 1792.507060558344, 1797.0924683035114, 1805.3861687026342, 1818.4271954334342, 1828.8354048135732, 1863.394396821025, 1865.8880467171878, 1877.6150889067708, 1881.604862978776, 6437.324080971477, 6541.182352205974, 6577.309382514863, 6608.735650573972, 6635.43598794103, 3904.7657140571655, 3931.8623848165175, 3990.3615421532418, 4003.899902502432, 4058.2492238935597, 2118.1103936346617, 2140.892955352226, 2370.7155141383146, 2440.389902524369, 2470.493548822505, 724.3336130759714, 743.1453828097731, 745.0537816972414, 748.5097261293861, 755.5051441305953, 8658.307335413152, 8659.350548708871, 8663.220310172052, 8762.386632935697, 8797.164269394398, 3631.418972964313, 3645.671889529955, 3681.834317455667, 3683.852645894188, 3686.0047787097333, 7540.245975402526, 7553.660085296175, 7570.924290757132, 7612.657430415645, 7613.352865006536, 4030.8992275193355, 4060.2285565743005, 4061.248668996245, 4073.490813648294, 4128.637549608622, 3665.8533658653887, 3687.870924517683, 3707.2400157967554, 3729.179580492287, 3734.290484807878, 3088.90733278002, 3091.984540077285, 3125.968740312613, 3162.778605497639, 3163.620365556148, 1022.320157095538, 1035.9896401035894, 1040.9011143941314, 1046.6546039806844, 1050.7425680708122, 1066.3069005146717, 1084.7017070305728, 1102.9558817647364, 1103.1340397787699, 1111.988090837334, 6208.627482351073, 6220.191375121205, 6248.718807653667, 6277.0, 6278.246610406781, 369.4236990295148, 377.61483287047605, 377.6186052087357, 378.75002498350955, 380.3420083255983, 4845.806167753321, 4858.5384388483035, 4867.148249056401, 4909.239067944474, 4922.310876477296, 7526.849463010709, 7821.061472623322, 7876.369890408753, 7896.289333959971, 7933.523988560705, 7744.728934487266, 7804.882926756103, 7813.804654883674, 7865.370770338359, 7869.842603147905, 5887.558433117533, 6044.214252147281, 6048.606840555438, 6164.137020817089, 6237.594556353823, 6193.0, 6196.876062478816, 6228.626282423069, 6238.282597501164, 6242.968785156045, 6834.965825170842, 6926.688299026657, 6975.441964642715, 6998.580085194904, 7034.191068027242, 6843.965780171067, 7161.606111663908, 7206.639668016683, 7212.783616491513, 7279.417646588367, 5806.390329015392, 5890.14592884038, 5902.321233058082, 5908.852278693067, 5915.40845915405, 5753.683547404766, 6244.594101383395, 6355.777547785805, 6371.872562548816, 6393.1369265148605, 5831.183634291117, 5858.736356864037, 5861.472467477947, 5884.617499862496, 5896.204012458435, 5733.397993210653, 5783.566232532661, 5825.0679891217205, 5833.416658334133, 5843.2403787507355, 5898.793542226002, 5930.169776231417, 5938.703064846827, 5949.553783466344, 5949.613275137102, 5126.820561280487, 5342.492463215988, 5397.622166448311, 5423.972880135574, 5451.56387488992, 4924.261360795909, 5035.118854200427, 5315.973420132875, 5377.650452720561, 5387.676739395649], "ext.html": [448.51336300114394, 457.3848174205694, 463.12931688425755, 479.58276299619337, 488.430977910734, 31238.84380578097, 32332.35335293293, 32535.837320813393, 32838.343233135325, 33046.86054824788, 34740.47889281663, 34746.478802817976, 34750.8262458688, 35084.64915350852, 35266.2946741065, 7350.191478937326, 7494.812629684247, 7527.623618819064, 7558.0, 7637.045369328834, 7361.9631901840685, 7450.925490745078, 7464.440166987471, 7542.245775422469, 7561.7731468056045, 7429.182789893108, 7495.2130026346995, 7503.287187717158, 7577.810554736148, 7595.278448547379, 7406.62966851658, 7485.438592105614, 7502.962485187593, 7517.624118794039, 7581.3555847753005, 7466.701331946716, 7467.887981680279, 7468.47720659554, 7477.551346919148, 7575.545467271982, 32486.0, 32534.349313013845, 32561.348773024645, 32943.34113317744, 32968.505472417935, 2499.3751562109474, 2506.699196096462, 2596.065416450095, 2655.292503257191, 2814.4667365398873, 22009.0, 22667.77332226673, 23083.769162308497, 23094.884525577432, 23473.41316467085, 1880.8119188081218, 1890.8392786613153, 1895.4597939587288, 1899.373206841739, 1910.8184722451344, 212993.0, 213119.0, 214180.0, 214981.0, 215073.0, 45402.545974540495, 45986.31020534695, 49755.502444975085, 51352.229716554284, 51641.741791291555, 47699.0, 48079.278810817865, 48449.273260901115, 49215.0, 49343.25985110226, 13401.66495837612, 13460.125091868997, 13524.45902163922, 13609.863901360859, 13624.0, 10165.0, 10194.286399951932, 10294.279400441897, 10322.896771032194, 10506.0, 15573.454929077428, 15718.449854255276, 15785.526434206991, 15787.447439339569, 16059.919700401657, 6337.479005038757, 6500.837479063061, 6518.087467754518, 6519.902201466982, 6532.5753826001155, 730.6310313291754, 761.7410080572632, 795.6697970342243, 833.8499070167306, 840.7940054686641, 22832.200872969366, 22834.42913927165, 23153.189638362914, 23157.652635210485, 23327.0, 809.6761295481855, 814.8125931035777, 853.108501615813, 869.4565896314804, 872.7120050383359, 12460.376981150906, 12521.186122901981, 12542.0, 12778.872211277954, 12816.935915320364, 241384.0, 244138.0, 246325.0, 247471.0, 247785.0, 43833.34249986253, 43895.12209755787, 43913.78043109764, 44198.55801442009, 44286.11427771427, 1111.7109551516503, 1131.6548452722, 1134.0983917785381, 1141.4863311509853, 1142.3031950510183, 23506.529869402857, 23597.764022359555, 23601.0, 23806.523869522167, 23808.761912381346, 37109.0, 37580.87257382283, 38020.61979380171, 38030.80984595059, 38385.54530092305, 209844.0, 211857.0, 212259.0, 213038.0, 214059.0, 24760.752392475846, 25081.372965676004, 25559.105431309814, 25978.35054123662, 26130.73869261283, 32886.34227315488, 33170.336593267515, 33563.16092097717, 33599.16002099967, 33672.0, 28381.822361253886, 28475.0, 28574.714252858037, 28637.0, 28832.279193020342, 27119.72880271251, 27496.312592184557, 27786.44427111487, 27830.469324187365, 28059.43881122407, 27635.170944871687, 27715.861420692767, 28288.15135545937, 28564.31799629658, 28604.0, 24422.63366049475, 25122.748772512772, 25127.0, 25625.487490249718, 25752.742472575035, 19158.712619311, 19404.320848770225, 19526.8047319525, 19537.60924781525, 19771.0], "prototype.html": [255.7429783068017, 261.24239704855927, 261.4692174884983, 261.47052219256017, 265.42800265428, 4941.061198372316, 4991.999999999995, 5027.849164525061, 5046.621503387242, 5070.594352451804, 4967.329410529577, 4974.502549745023, 5005.824796132136, 5012.997400519892, 5015.598752099832, 3893.0462036801023, 3906.1015966327764, 3913.3738601823716, 3914.138889444332, 3962.6829853611644, 3880.2821478026513, 3898.259330727167, 3907.6873850092065, 3935.8425662973445, 3958.4853968984135, 3854.710896682746, 3866.5360156781085, 3897.9025524361978, 3898.3567711327596, 3906.199229158016, 3696.0944568580735, 3777.3956167013284, 3795.221979494225, 3824.292505886392, 3849.3840985442193, 3191.7287030602192, 3197.776155669104, 3207.0378886334006, 3234.514822776579, 3284.293876816496, 4827.903441931142, 4862.465128835825, 4884.3650325457465, 4892.902141957141, 4910.263460480921, 4180.184863951531, 4205.621494065518, 4213.789310534461, 4222.113356195203, 4237.724547904377, 4982.17794063979, 5119.539241468248, 5119.66722163062, 5128.0, 5247.501487358695, 3581.982090089559, 3586.8565257389673, 3591.1740299730945, 3598.334308152974, 3630.49173115764, 5318.840434786963, 5422.457754224546, 5436.075867102602, 5506.03644362235, 5518.779248830042, 3641.5630124385243, 3646.8176591170336, 3654.561452625702, 3662.285854258394, 3678.6321367863, 3686.889393318205, 3727.5713292971654, 3760.9435858462143, 3762.924741505209, 3767.830447629863, 4299.957000429956, 4311.1808756336195, 4314.784260787011, 4322.113966636832, 4327.502337231196, 5214.504622060898, 5248.973755131276, 5252.133397989365, 5291.074062039204, 5318.521333080042, 1328.1632571479906, 1369.9931500342634, 1371.4240019191964, 1373.176094343386, 1375.7454870848726, 881.6209030116983, 887.316766090107, 903.0202230579763, 907.1518130547959, 908.8591268353416, 5012.799488020439, 5017.272495488134, 5026.09530284545, 5050.0, 5107.97446012775, 5496.0, 5536.501714845684, 5593.74828132735, 5595.21666966625, 5615.8876822464135, 5023.949760502422, 5027.0, 5052.090623687698, 5105.566026887682, 5131.4868513148385, 2967.6438827340858, 3029.8939537116535, 3058.1895797613206, 3097.132802815215, 3103.8603262853226, 5643.0, 5671.6597004179885, 5673.716314184357, 5725.541956643458, 5736.053551164095, 5632.464915832989, 5679.403662615448, 5713.143028545752, 5717.656940583578, 5719.256496655408, 5659.320881494247, 5683.204351390808, 5698.259226300637, 5736.368999410061, 5744.856378590569, 5268.157094864803, 5367.0, 5369.758360873848, 5463.890722185454, 5518.365387980433, 5309.097453433003, 5361.865953351197, 5401.135818269216, 5419.756110974937, 5424.864378390414, 5507.917381239205, 5645.463680950304, 5692.146178073156, 5710.457506536873, 5717.799877004285, 3481.199324155408, 3499.4051011328643, 3501.63232860546, 3509.666581674737, 3511.2450823073164, 5358.437364076716, 5461.34463864323, 5483.506484416422, 5502.2296878436255, 5540.63985840919, 5299.364076310867, 5306.495882891119, 5329.893402132013, 5380.3274590676165, 5415.5126038655135, 5225.216217567396, 5299.894002119859, 5301.23132145829, 5381.650192737459, 5391.865203369947, 5019.598432125348, 5167.328247327973, 5171.586273098068, 5184.507471790174, 5228.085085110167, 5282.524572788468, 5328.973355133199, 5333.7333133343955, 5401.702906340189, 5488.1493368527945, 5292.3649162099255, 5296.0, 5303.496167864047, 5355.758990845344, 5403.8108666196495], "yui.html": [539.8488423241491, 561.3544423912501, 568.5707290995298, 600.4415893219307, 603.2128072864913, 11094.833577496334, 11300.547978080876, 11315.886841131587, 11350.20548561599, 11397.886021139775, 10389.584416623326, 10459.477026148681, 10621.73445663857, 11569.305841649508, 11570.132240081986, 554.0940562180843, 562.4375624375624, 696.655155697929, 712.0138608027893, 720.466854527651, 683.9008343790148, 686.8969654551807, 697.5221972948522, 697.7662483068178, 698.3854208296692, 717.1072015340908, 740.6148802622633, 741.5847125609649, 742.1465314887895, 742.806870213743, 718.1346477494607, 729.1468981291902, 729.4893574497846, 730.0254160695451, 730.7807657702695, 530.4509832323565, 533.0564900126793, 540.124997504046, 540.497337476147, 541.5559241422036, 11146.944265278702, 11155.609553665583, 11158.218924675277, 11292.491837867316, 11310.660680179608, 7323.48735588509, 7497.887531687029, 7680.418263233471, 7738.0, 8338.124496927856, 6921.826954326132, 7108.253633368526, 7164.21193668696, 7188.532745371586, 7212.819679508002, 2402.783749462557, 2429.878506074707, 2456.65606815046, 2487.4278915849277, 2541.7077036140895, 38483.23033539342, 39097.60902390968, 39293.0, 39336.803315983234, 39446.211075778614, 5604.047311956977, 5645.237892884408, 5703.486686198262, 5778.0, 5874.882502350015, 9926.404415735078, 9946.35348702332, 9949.850752238723, 10066.949665251774, 10094.293399461967, 4773.069251495925, 4795.448523419851, 4817.879553011203, 4874.926876096862, 4899.804007839718, 3063.5557844112923, 3065.2796592800673, 3075.8923437679573, 3087.6140482439696, 3096.535519672067, 2163.0482587661377, 2200.614892393825, 2212.579609874119, 2217.356966479735, 2229.5206530596, 313.0077653837341, 315.4920577869628, 316.1227593428255, 318.75933670079405, 322.85794250529693, 408.6118187721676, 419.33326011641634, 430.7286409561956, 466.6266986410858, 496.95527402533946, 5987.730552125165, 6481.708323125471, 6519.478441724651, 6593.340665933464, 6667.699953502104, 467.6601536597691, 470.21943573667545, 492.97707257440953, 499.4506043352356, 500.3495455907306, 2974.553816927435, 3135.4826453634896, 3262.706356427933, 3311.122552523583, 3326.5176549400203, 47378.289325660146, 47589.0, 48252.27621585679, 48508.27237591439, 48623.5137648619, 42217.57782422198, 42283.36574951378, 42460.150796983886, 42537.14925701469, 42774.57225427768, 38440.03899902525, 38640.673973368765, 39165.608343916196, 39491.80254098711, 39880.800595996836, 6478.870422591616, 6611.867762644816, 6646.235682896336, 6743.325667433218, 6840.384365407137, 28111.0, 28607.141785746462, 28690.380032109006, 29228.415431691672, 29403.705962940097, 34829.691179337926, 34949.0, 35911.92264232077, 38186.61813381831, 38494.615053849106, 5970.373110823301, 6122.877542449215, 6243.500519958302, 6301.842453938688, 6440.581362211441, 8379.874301885355, 8798.692045778367, 9216.608264198938, 9330.95334523323, 9383.0, 8568.828623427622, 8793.472391656522, 8816.074312197383, 8898.42160259581, 8945.59744811498, 8731.738047858575, 8812.691555795516, 8830.779230519289, 8842.071582484004, 8922.107789221025, 7656.693732250647, 7988.0, 8293.543855088028, 8498.362622803192, 8653.826923461369, 6896.965515172593, 7182.328700912382, 7496.7750967471065, 7676.53940763556, 7774.30031297186, 7067.787966361017, 7360.558366498028, 7396.887566711093, 7666.271704188316, 7735.110462296908]}, "summary": {"lowerIsBetter": false, "suite": 5503.250872427669, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 6129.631266291906, "unit": "ms", "value": 6129.631266291906}, "dojo.html": {"lowerIsBetter": false, "filtered": 4452.815666874275, "unit": "ms", "value": 4452.815666874275}, "mootools.html": {"lowerIsBetter": false, "filtered": 3666.6192067536977, "unit": "ms", "value": 3666.6192067536977}, "ext.html": {"lowerIsBetter": false, "filtered": 14822.702855993088, "unit": "ms", "value": 14822.702855993088}, "prototype.html": {"lowerIsBetter": false, "filtered": 3980.46226436804, "unit": "ms", "value": 3980.46226436804}, "yui.html": {"lowerIsBetter": false, "filtered": 4704.094407682403, "unit": "ms", "value": 4704.094407682403}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0023.e"}, "testrun": {"date": 1447296138, "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": "20151111164246", "branch": "Firefox", "revision": "e86bdbfed16469a76af03f0682e215ec33b2ee74"}}, {"talos_counters": {}, "results": {"audio-dft": [214.0, 207.0, 209.0, 201.0, 202.0, 204.0, 211.0, 210.0, 204.0, 201.0], "ai-astar": [133.0, 130.0, 143.0, 141.0, 138.0, 144.0, 134.0, 140.0, 140.0, 142.0], "imaging-gaussian-blur": [157.0, 150.0, 152.0, 150.0, 157.0, 156.0, 143.0, 151.0, 157.0, 147.0], "audio-beat-detection": [192.0, 170.0, 200.0, 211.0, 169.0, 187.0, 188.0, 164.0, 196.0, 167.0], "json-stringify-tinderbox": [83.0, 85.0, 88.0, 88.0, 86.0, 87.0, 87.0, 83.0, 84.0, 83.0], "stanford-crypto-pbkdf2": [180.0, 205.0, 206.0, 203.0, 196.0, 196.0, 202.0, 202.0, 201.0, 192.0], "json-parse-financial": [73.0, 76.0, 80.0, 82.0, 83.0, 82.0, 83.0, 89.0, 80.0, 81.0], "stanford-crypto-sha256-iterative": [83.0, 89.0, 89.0, 96.0, 95.0, 93.0, 93.0, 93.0, 95.0, 93.0], "audio-fft": [86.0, 97.0, 103.0, 150.0, 84.0, 86.0, 92.0, 88.0, 124.0, 81.0], "imaging-darkroom": [163.0, 164.0, 162.0, 156.0, 164.0, 166.0, 156.0, 164.0, 166.0, 161.0], "stanford-crypto-ccm": [161.0, 168.0, 162.0, 172.0, 160.0, 171.0, 168.0, 164.0, 165.0, 164.0], "audio-oscillator": [108.0, 109.0, 157.0, 112.0, 114.0, 114.0, 151.0, 108.0, 109.0, 154.0], "stanford-crypto-aes": [108.0, 113.0, 112.0, 112.0, 114.0, 114.0, 113.0, 108.0, 109.0, 115.0], "imaging-desaturate": [127.0, 138.0, 137.0, 136.0, 133.0, 134.0, 134.0, 135.0, 132.0, 133.0]}, "summary": {"lowerIsBetter": true, "suite": 1933.8000000000004, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 99.1, "unit": "ms", "value": 99.1}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 198.3, "unit": "ms", "value": 198.3}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 184.4, "unit": "ms", "value": 184.4}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 165.5, "unit": "ms", "value": 165.5}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 162.2, "unit": "ms", "value": 162.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 80.9, "unit": "ms", "value": 80.9}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 123.6, "unit": "ms", "value": 123.6}, "ai-astar": {"lowerIsBetter": true, "filtered": 138.5, "unit": "ms", "value": 138.5}, "audio-dft": {"lowerIsBetter": true, "filtered": 206.3, "unit": "ms", "value": 206.3}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 91.9, "unit": "ms", "value": 91.9}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 85.4, "unit": "ms", "value": 85.4}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 152.0, "unit": "ms", "value": 152.0}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 111.8, "unit": "ms", "value": 111.8}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 133.9, "unit": "ms", "value": 133.9}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0023.e"}, "testrun": {"date": 1447296138, "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": "20151111164246", "branch": "Firefox", "revision": "e86bdbfed16469a76af03f0682e215ec33b2ee74"}}, {"talos_counters": {}, "results": {"DeltaBlue": [243.66471734892787], "Encrypt": [387.8975950349108], "NavierStokes": [7244.604316546763], "Decrypt": [7049.295774647887], "Splay": [843.8818565400844], "Richards": [901.7132551848512], "RegExp": [35210.52631578947], "Earley": [964.3201542912246], "Boyer": [15936.507936507936], "RayTrace": [1400.5602240896358]}, "summary": {"lowerIsBetter": false, "suite": 13678.446543830585, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 271.348272, "unit": "score", "value": 271.348272}, "Encrypt": {"lowerIsBetter": false, "filtered": 686.2146180000002, "unit": "score", "value": 686.2146180000002}, "NavierStokes": {"lowerIsBetter": false, "filtered": 204.842105263158, "unit": "score", "value": 204.842105263158}, "Decrypt": {"lowerIsBetter": false, "filtered": 37.75994205794205, "unit": "score", "value": 37.75994205794205}, "Splay": {"lowerIsBetter": false, "filtered": 96.56683500000003, "unit": "score", "value": 96.56683500000003}, "RegExp": {"lowerIsBetter": false, "filtered": 25.87251868460387, "unit": "score", "value": 25.87251868460387}, "Richards": {"lowerIsBetter": false, "filtered": 39.14991800000001, "unit": "score", "value": 39.14991800000001}, "Earley": {"lowerIsBetter": false, "filtered": 691.1221310000003, "unit": "score", "value": 691.1221310000003}, "Boyer": {"lowerIsBetter": false, "filtered": 41.81988944223107, "unit": "score", "value": 41.81988944223107}, "RayTrace": {"lowerIsBetter": false, "filtered": 528.3521460000002, "unit": "score", "value": 528.3521460000002}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0023.e"}, "testrun": {"date": 1447296138, "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": "20151111164246", "branch": "Firefox", "revision": "e86bdbfed16469a76af03f0682e215ec33b2ee74"}}] 19:02:38 INFO - RETURN: dromaeo_css: 5503.25 19:02:38 INFO - RETURN: kraken: 1933.80 19:02:38 INFO - RETURN: v8_7: 13678.45 19:02:38 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,57]]", "result": "13678.45"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,57]]", "result": "1933.80"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,57]]", "result": "5503.25"}}} 19:02:38 INFO - Return code: 0 19:02:38 INFO - # TBPL SUCCESS # 19:02:38 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 19:02:38 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 19:02:38 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 19:02:38 INFO - 2015-11-11 19:02:38.105 screenresolution[1655:10629] starting screenresolution argv=screenresolution get 19:02:38 INFO - 2015-11-11 19:02:38.110 screenresolution[1655:10629] Display 0: 1600x1200x32@60 19:02:38 INFO - 2015-11-11 19:02:38.117 screenresolution[1656:10632] starting screenresolution argv=screenresolution list 19:02:38 INFO - Available Modes on Display 0 19:02:38 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 19:02:38 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 19:02:38 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 19:02:38 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 19:02:38 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 19:02:38 INFO - Intel HD Graphics 3000: 19:02:38 INFO - Chipset Model: Intel HD Graphics 3000 19:02:38 INFO - Type: GPU 19:02:38 INFO - Bus: Built-In 19:02:38 INFO - VRAM (Total): 512 MB 19:02:38 INFO - VRAM (Dynamic, Max): 10 19:02:38 INFO - Vendor: Intel (0x8086) 19:02:38 INFO - Device ID: 0x0116 19:02:38 INFO - Revision ID: 0x0009 19:02:38 INFO - Displays: 19:02:38 INFO - Display: 19:02:38 INFO - Resolution: 1600 x 1200 @ 60 Hz 19:02:38 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 19:02:38 INFO - Display Serial Number: 1600x1200 60 19:02:38 INFO - Main Display: Yes 19:02:38 INFO - Mirror: Off 19:02:38 INFO - Online: Yes 19:02:38 INFO - Rotation: Supported 19:02:38 INFO - Return code: 0 19:02:38 INFO - Running post-action listener: _resource_record_post_action 19:02:38 INFO - Running post-run listener: _resource_record_post_run 19:02:39 INFO - Total resource usage - Wall time: 1264s; CPU: 30.0%; Read bytes: 39887872; Write bytes: 691450880; Read time: 4398; Write time: 60907 19:02:39 INFO - install - Wall time: 44s; CPU: 30.0%; Read bytes: 339501568; Write bytes: 337104896; Read time: 38127; Write time: 5853 19:02:39 INFO - run-tests - Wall time: 1221s; CPU: 30.0%; Read bytes: 38130688; Write bytes: 343159808; Read time: 4104; Write time: 54417 19:02:39 INFO - Running post-run listener: _upload_blobber_files 19:02:39 INFO - Blob upload gear active. 19:02:39 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 19:02:39 INFO - Copying logs to upload dir... 19:02:39 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1323.752537 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 3 secs) (at 2015-11-11 19:02:39.575506) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-11 19:02:39.579145) ========= 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.iMXLQy1McM/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.UgTVGkwdgx/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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/N054OqWoSXyn9Y-hYQuwlA/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011244 build_url: 'https://queue.taskcluster.net/v1/task/N054OqWoSXyn9Y-hYQuwlA/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-11 19:02:39.609455) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:02:39.609899) ========= 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.iMXLQy1McM/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.UgTVGkwdgx/Listeners TMPDIR=/var/folders/h3/pfcg1qv53kqf79dlg14gw1cw00000w/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.006114 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-11 19:02:39.660778) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 19:02:39.661153) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-11 19:02:39.661590) ========= ========= Total master_lag: 0.22 =========