builder: fx-team_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0002 starttime: 1447963224.5 results: success (0) buildid: 20151119095206 builduid: 7f904cad1e9c40938a7c852298b1b5de revision: 4a5ad4d3df92bda0d3138befc40cbf6084714d79 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:24.505340) ========= master: http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:24.505834) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:24.506148) ========= 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.Q9FfmA2y2M/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.2h5rlyCti9/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.005308 basedir: '/builds/slave/test' ========= master_lag: 0.02 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:24.534308) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:24.534643) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:24.550656) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:24.551046) ========= 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.Q9FfmA2y2M/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.2h5rlyCti9/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005652 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:24.599347) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:24.599705) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:24.600078) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:24.600383) ========= 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.Q9FfmA2y2M/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.2h5rlyCti9/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2015-11-19 12:00:24-- 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.41G=0s 2015-11-19 12:00:24 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.110275 ========= master_lag: 0.01 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:24.725453) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:24.725946) ========= 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.Q9FfmA2y2M/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.2h5rlyCti9/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.024707 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:24.775404) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2015-11-19 12:00:24.775772) ========= bash -c 'python archiver_client.py mozharness --repo integration/fx-team --rev 4a5ad4d3df92bda0d3138befc40cbf6084714d79 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo integration/fx-team --rev 4a5ad4d3df92bda0d3138befc40cbf6084714d79 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Q9FfmA2y2M/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.2h5rlyCti9/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2015-11-19 12:00:24,854 truncating revision to first 12 chars 2015-11-19 12:00:24,855 Setting DEBUG logging. 2015-11-19 12:00:24,855 attempt 1/10 2015-11-19 12:00:24,855 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/integration/fx-team/4a5ad4d3df92?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-19 12:00:25,889 unpacking tar archive at: fx-team-4a5ad4d3df92/testing/mozharness/ program finished with exit code 0 elapsedTime=1.275995 ========= master_lag: 7.06 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 8 secs) (at 2015-11-19 12:00:33.114887) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:33.115265) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:33.292265) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:33.292677) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-19 12:00:33.293278) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-11-19 12:00:33.293615) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Fx-Team', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Fx-Team'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Q9FfmA2y2M/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.2h5rlyCti9/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 12:00:33 INFO - MultiFileLogger online at 20151119 12:00:33 in /builds/slave/test 12:00:33 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Fx-Team --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Fx-Team 12:00:33 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 12:00:33 INFO - {'append_to_log': False, 12:00:33 INFO - 'base_work_dir': '/builds/slave/test', 12:00:33 INFO - 'blob_upload_branch': 'Fx-Team', 12:00:33 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 12:00:33 INFO - 'branch': 'Fx-Team', 12:00:33 INFO - 'buildbot_json_path': 'buildprops.json', 12:00:33 INFO - 'config_files': ('talos/mac_config.py',), 12:00:33 INFO - 'default_actions': ('clobber', 12:00:33 INFO - 'read-buildbot-config', 12:00:33 INFO - 'download-and-extract', 12:00:33 INFO - 'populate-webroot', 12:00:33 INFO - 'create-virtualenv', 12:00:33 INFO - 'install', 12:00:33 INFO - 'run-tests'), 12:00:33 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 12:00:33 INFO - 'download_minidump_stackwalk': True, 12:00:33 INFO - 'download_symbols': 'ondemand', 12:00:33 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 12:00:33 INFO - 'tooltool.py': '/tools/tooltool.py', 12:00:33 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 12:00:33 INFO - '/tools/misc-python/virtualenv.py')}, 12:00:33 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 12:00:33 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 12:00:33 INFO - 'installer_path': 'installer.exe', 12:00:33 INFO - 'log_level': 'info', 12:00:33 INFO - 'log_name': 'talos', 12:00:33 INFO - 'log_to_console': True, 12:00:33 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 12:00:33 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 12:00:33 INFO - 'opt_config_files': (), 12:00:33 INFO - 'pip_index': False, 12:00:33 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:00:33 INFO - 'cmd': ('bash', 12:00:33 INFO - '-c', 12:00:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:00:33 INFO - 'enabled': True, 12:00:33 INFO - 'halt_on_failure': False, 12:00:33 INFO - 'name': 'check_screen_resolution'},), 12:00:33 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 12:00:33 INFO - 'cmd': ('bash', 12:00:33 INFO - '-c', 12:00:33 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 12:00:33 INFO - 'enabled': True, 12:00:33 INFO - 'halt_on_failure': False, 12:00:33 INFO - 'name': 'check_screen_resolution'},), 12:00:33 INFO - 'run_cmd_checks_enabled': True, 12:00:33 INFO - 'sps_profile': False, 12:00:33 INFO - 'sps_profile_interval': 0, 12:00:33 INFO - 'suite': 'dromaeojs-e10s', 12:00:33 INFO - 'system_bits': '64', 12:00:33 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 12:00:33 INFO - 'title': 't-yosemite-r7-0002', 12:00:33 INFO - 'tooltool_cache': '/builds/tooltool_cache', 12:00:33 INFO - 'use_talos_json': True, 12:00:33 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 12:00:33 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 12:00:33 INFO - 'work_dir': 'build'} 12:00:33 INFO - ##### 12:00:33 INFO - ##### Running clobber step. 12:00:33 INFO - ##### 12:00:33 INFO - Running pre-action listener: _resource_record_pre_action 12:00:33 INFO - Running main action method: clobber 12:00:33 INFO - rmtree: /builds/slave/test/build 12:00:33 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 12:00:34 INFO - Running post-action listener: _resource_record_post_action 12:00:34 INFO - ##### 12:00:34 INFO - ##### Running read-buildbot-config step. 12:00:34 INFO - ##### 12:00:34 INFO - Running pre-action listener: _resource_record_pre_action 12:00:34 INFO - Running main action method: read_buildbot_config 12:00:34 INFO - Using buildbot properties: 12:00:34 INFO - { 12:00:34 INFO - "properties": { 12:00:34 INFO - "buildnumber": 13, 12:00:34 INFO - "product": "firefox", 12:00:34 INFO - "script_repo_revision": "production", 12:00:34 INFO - "builddir": "fx-team_yosemite_r7_test-dromaeojs-e10s", 12:00:34 INFO - "repository": "", 12:00:34 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10.5 fx-team talos dromaeojs-e10s", 12:00:34 INFO - "buildid": "20151119095206", 12:00:34 INFO - "slavename": "t-yosemite-r7-0002", 12:00:34 INFO - "pgo_build": "False", 12:00:34 INFO - "basedir": "/builds/slave/test", 12:00:34 INFO - "project": "", 12:00:34 INFO - "platform": "yosemite_r7", 12:00:34 INFO - "master": "http://buildbot-master106.bb.releng.scl3.mozilla.com:8201/", 12:00:34 INFO - "slavebuilddir": "test", 12:00:34 INFO - "scheduler": "tests-fx-team-macosx64-talos", 12:00:34 INFO - "branch": "fx-team", 12:00:34 INFO - "repo_path": "integration/fx-team", 12:00:34 INFO - "stage_platform": "macosx64", 12:00:34 INFO - "builduid": "7f904cad1e9c40938a7c852298b1b5de", 12:00:34 INFO - "revision": "4a5ad4d3df92bda0d3138befc40cbf6084714d79" 12:00:34 INFO - }, 12:00:34 INFO - "sourcestamp": { 12:00:34 INFO - "repository": "", 12:00:34 INFO - "hasPatch": false, 12:00:34 INFO - "project": "", 12:00:34 INFO - "branch": "fx-team-macosx64-talos", 12:00:34 INFO - "changes": [ 12:00:34 INFO - { 12:00:34 INFO - "category": null, 12:00:34 INFO - "files": [ 12:00:34 INFO - { 12:00:34 INFO - "url": null, 12:00:34 INFO - "name": "https://queue.taskcluster.net/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 12:00:34 INFO - } 12:00:34 INFO - ], 12:00:34 INFO - "repository": "", 12:00:34 INFO - "rev": "4a5ad4d3df92bda0d3138befc40cbf6084714d79", 12:00:34 INFO - "who": "apoirot@mozilla.com", 12:00:34 INFO - "when": 1447958194, 12:00:34 INFO - "number": 6684174, 12:00:34 INFO - "comments": "Bug 1198877 - Support building FxOS simulators from try builds. r=jryans", 12:00:34 INFO - "project": "", 12:00:34 INFO - "at": "Thu 19 Nov 2015 10:36:34", 12:00:34 INFO - "branch": "fx-team-macosx64-talos", 12:00:34 INFO - "revlink": "", 12:00:34 INFO - "properties": [ 12:00:34 INFO - [ 12:00:34 INFO - "buildid", 12:00:34 INFO - "20151119095206", 12:00:34 INFO - "Change" 12:00:34 INFO - ], 12:00:34 INFO - [ 12:00:34 INFO - "builduid", 12:00:34 INFO - "7f904cad1e9c40938a7c852298b1b5de", 12:00:34 INFO - "Change" 12:00:34 INFO - ], 12:00:34 INFO - [ 12:00:34 INFO - "pgo_build", 12:00:34 INFO - "False", 12:00:34 INFO - "Change" 12:00:34 INFO - ] 12:00:34 INFO - ], 12:00:34 INFO - "revision": "4a5ad4d3df92bda0d3138befc40cbf6084714d79" 12:00:34 INFO - } 12:00:34 INFO - ], 12:00:34 INFO - "revision": "4a5ad4d3df92bda0d3138befc40cbf6084714d79" 12:00:34 INFO - } 12:00:34 INFO - } 12:00:34 INFO - Found installer url https://queue.taskcluster.net/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 12:00:34 INFO - Running post-action listener: _resource_record_post_action 12:00:34 INFO - ##### 12:00:34 INFO - ##### Running download-and-extract step. 12:00:34 INFO - ##### 12:00:34 INFO - Running pre-action listener: _resource_record_pre_action 12:00:34 INFO - Running main action method: download_and_extract 12:00:34 INFO - mkdir: /builds/slave/test/build/tests 12:00:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:34 INFO - https://queue.taskcluster.net/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 12:00:34 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/test_packages.json 12:00:34 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/test_packages.json 12:00:34 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 12:00:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 12:00:36 INFO - Downloaded 1149 bytes. 12:00:36 INFO - Reading from file /builds/slave/test/build/test_packages.json 12:00:36 INFO - Using the following test package requirements: 12:00:36 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:00:36 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:00:36 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 12:00:36 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:00:36 INFO - u'jsshell-mac.zip'], 12:00:36 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:00:36 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 12:00:36 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:00:36 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:00:36 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 12:00:36 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:00:36 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 12:00:36 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:00:36 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 12:00:36 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 12:00:36 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 12:00:36 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 12:00:36 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 12:00:36 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:36 INFO - https://queue.taskcluster.net/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:00:36 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:00:36 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:00:36 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/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 12:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/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 12:00:42 INFO - Downloaded 17522146 bytes. 12:00: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 12:00:42 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:00:42 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:00:44 INFO - Return code: 0 12:00:44 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 12:00:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:44 INFO - https://queue.taskcluster.net/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 12:00:44 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:00:44 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:00:44 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/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 12:00:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/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 12:00:45 INFO - Downloaded 17522146 bytes. 12:00:45 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 12:00:45 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 12:00:45 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 12:00:49 INFO - Return code: 0 12:00:49 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')]} 12:00:49 INFO - https://queue.taskcluster.net/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 12:00:49 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:00:49 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:00:49 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/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 12:00:49 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/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 12:00:50 INFO - Downloaded 11130997 bytes. 12:00:50 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 12:00:50 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 12:00:50 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 12:00:50 INFO - Return code: 0 12:00:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:00:50 INFO - https://queue.taskcluster.net/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 12:00:50 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:00:50 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:00:50 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 12:00:50 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/eqCAB4HTR46nx7CN1L9HWg/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 12:00:53 INFO - Downloaded 109363866 bytes. 12:00:53 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:00:53 INFO - mkdir: /builds/slave/test/properties 12:00:53 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 12:00:53 INFO - Writing to file /builds/slave/test/properties/build_url 12:00:53 INFO - Contents: 12:00:53 INFO - build_url:https://queue.taskcluster.net/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 12:00:53 INFO - Running post-action listener: _resource_record_post_action 12:00:53 INFO - Running post-action listener: set_extra_try_arguments 12:00:53 INFO - ##### 12:00:53 INFO - ##### Running populate-webroot step. 12:00:53 INFO - ##### 12:00:53 INFO - Running pre-action listener: _resource_record_pre_action 12:00:53 INFO - Running main action method: populate_webroot 12:00:53 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 12:00:53 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 12:00:53 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 12:00:53 INFO - '../fennec_ids.txt'], 12:00:53 INFO - 'tests': ['tcheck2']}, 12:00:53 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 12:00:53 INFO - '--tppagecycles', 12:00:53 INFO - '7'], 12:00:53 INFO - 'tests': ['tsvgm']}}, 12:00:53 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 12:00:53 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 12:00:53 INFO - 'tests': ['tresize', 'tcanvasmark']}, 12:00:53 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:00:53 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 12:00:53 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 12:00:53 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:00:53 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:53 INFO - 'talos_options': ['--e10s'], 12:00:53 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 12:00:53 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:53 INFO - 'tests': ['damp', 'tps']}, 12:00:53 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:53 INFO - 'talos_options': ['--e10s'], 12:00:53 INFO - 'tests': ['damp', 'tps']}, 12:00:53 INFO - 'g3': {'tests': ['dromaeo_dom']}, 12:00:53 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 12:00:53 INFO - 'other': {'tests': ['a11yr', 12:00:53 INFO - 'ts_paint', 12:00:53 INFO - 'tpaint', 12:00:53 INFO - 'sessionrestore', 12:00:53 INFO - 'sessionrestore_no_auto_restore']}, 12:00:53 INFO - 'other-e10s': {'talos_options': ['--e10s'], 12:00:53 INFO - 'tests': ['a11yr', 12:00:53 INFO - 'ts_paint', 12:00:53 INFO - 'tpaint', 12:00:53 INFO - 'sessionrestore', 12:00:53 INFO - 'sessionrestore_no_auto_restore']}, 12:00:53 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 12:00:53 INFO - 'tests': ['a11yr', 12:00:53 INFO - 'ts_paint', 12:00:53 INFO - 'tpaint', 12:00:53 INFO - 'sessionrestore', 12:00:53 INFO - 'sessionrestore_no_auto_restore']}, 12:00:53 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 12:00:53 INFO - 'tests': ['a11yr', 12:00:53 INFO - 'ts_paint', 12:00:53 INFO - 'tpaint', 12:00:53 INFO - 'sessionrestore', 12:00:53 INFO - 'sessionrestore_no_auto_restore']}, 12:00:53 INFO - 'other_l64': {'tests': ['a11yr', 12:00:53 INFO - 'ts_paint', 12:00:53 INFO - 'tpaint', 12:00:53 INFO - 'sessionrestore', 12:00:53 INFO - 'sessionrestore_no_auto_restore']}, 12:00:53 INFO - 'other_nol64': {'tests': ['a11yr', 12:00:53 INFO - 'ts_paint', 12:00:53 INFO - 'tpaint', 12:00:53 INFO - 'sessionrestore', 12:00:53 INFO - 'sessionrestore_no_auto_restore']}, 12:00:53 INFO - 'svgr': {'tests': ['tsvgx', 12:00:53 INFO - 'tsvgr_opacity', 12:00:53 INFO - 'tart', 12:00:53 INFO - 'tscrollx', 12:00:53 INFO - 'cart']}, 12:00:53 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 12:00:53 INFO - 'tests': ['tsvgx', 12:00:53 INFO - 'tsvgr_opacity', 12:00:53 INFO - 'tart', 12:00:53 INFO - 'tscrollx', 12:00:53 INFO - 'cart']}, 12:00:53 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:53 INFO - 'tests': ['tp5o']}, 12:00:53 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:53 INFO - 'talos_options': ['--e10s'], 12:00:53 INFO - 'tests': ['tp5o']}, 12:00:53 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:53 INFO - 'talos_options': ['--xperf_path', 12:00:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:00:53 INFO - 'tests': ['tp5n']}, 12:00:53 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 12:00:53 INFO - 'talos_options': ['--e10s', 12:00:53 INFO - '--xperf_path', 12:00:53 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 12:00:53 INFO - 'tests': ['tp5n']}}, 12:00:53 INFO - 'talos.zip': {'path': '', 12:00:53 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 12:00:53 INFO - Running post-action listener: _resource_record_post_action 12:00:53 INFO - ##### 12:00:53 INFO - ##### Running create-virtualenv step. 12:00:53 INFO - ##### 12:00:53 INFO - Running pre-action listener: _resource_record_pre_action 12:00:53 INFO - Running main action method: create_virtualenv 12:00:53 INFO - Creating virtualenv /builds/slave/test/build/venv 12:00:53 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 12:00:53 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 12:00:53 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 12:00:53 INFO - Using real prefix '/tools/python27' 12:00:53 INFO - New python executable in /builds/slave/test/build/venv/bin/python 12:00:54 INFO - Installing distribute.............................................................................................................................................................................................done. 12:00:57 INFO - Installing pip.................done. 12:00:57 INFO - Return code: 0 12:00:57 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 12:00:57 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')]} 12:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:57 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')]} 12:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:57 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 0x105f95490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f72228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8510490100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb99f0>, '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 0x105c18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eac8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q9FfmA2y2M/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.2h5rlyCti9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:00:57 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 12:00:57 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 12:00:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q9FfmA2y2M/Render', 12:00:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:00:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:00:57 INFO - 'HOME': '/Users/cltbld', 12:00:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:00:57 INFO - 'LOGNAME': 'cltbld', 12:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:57 INFO - 'MOZ_NO_REMOTE': '1', 12:00:57 INFO - 'NO_EM_RESTART': '1', 12:00:57 INFO - 'PAGER': '/bin/cat', 12:00:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:57 INFO - 'PWD': '/builds/slave/test', 12:00:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:00:57 INFO - 'SHELL': '/bin/bash', 12:00:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2h5rlyCti9/Listeners', 12:00:57 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:00:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:00:57 INFO - 'USER': 'cltbld', 12:00:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:00:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:57 INFO - 'XPC_FLAGS': '0x0', 12:00:57 INFO - 'XPC_SERVICE_NAME': '0', 12:00:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:57 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 12:00:57 INFO - Cleaning up... 12:00:57 INFO - Return code: 0 12:00:57 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 12:00:57 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')]} 12:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:57 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')]} 12:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:00:57 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 0x105f95490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f72228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8510490100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb99f0>, '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 0x105c18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eac8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q9FfmA2y2M/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.2h5rlyCti9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:00:57 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 12:00:57 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 12:00:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q9FfmA2y2M/Render', 12:00:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:00:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:00:57 INFO - 'HOME': '/Users/cltbld', 12:00:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:00:57 INFO - 'LOGNAME': 'cltbld', 12:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:00:57 INFO - 'MOZ_NO_REMOTE': '1', 12:00:57 INFO - 'NO_EM_RESTART': '1', 12:00:57 INFO - 'PAGER': '/bin/cat', 12:00:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:00:57 INFO - 'PWD': '/builds/slave/test', 12:00:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:00:57 INFO - 'SHELL': '/bin/bash', 12:00:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2h5rlyCti9/Listeners', 12:00:57 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:00:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:00:57 INFO - 'USER': 'cltbld', 12:00:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:00:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:00:57 INFO - 'XPC_FLAGS': '0x0', 12:00:57 INFO - 'XPC_SERVICE_NAME': '0', 12:00:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:00:57 INFO - Downloading/unpacking psutil>=0.7.1 12:00:57 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 12:00:57 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 12:00:57 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 12:00:57 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 12:00:57 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 12:00:57 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 12:01:00 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 12:01:00 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 12:01:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 12:01:00 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:01:00 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:01:00 INFO - Installing collected packages: psutil 12:01:00 INFO - Running setup.py install for psutil 12:01:00 INFO - building 'psutil._psutil_osx' extension 12:01:00 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 12:01:01 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 12:01:01 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 12:01:01 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 12:01:01 INFO - building 'psutil._psutil_posix' extension 12:01:01 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 12:01:01 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 12:01:01 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 12:01:01 INFO - ^ 12:01:01 INFO - 1 warning generated. 12:01:01 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 12:01:01 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 12:01:01 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 12:01:01 INFO - Successfully installed psutil 12:01:01 INFO - Cleaning up... 12:01:01 INFO - Return code: 0 12:01:01 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 12:01:01 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')]} 12:01:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:01 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')]} 12:01:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:01 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 0x105f95490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f72228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8510490100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb99f0>, '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 0x105c18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eac8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q9FfmA2y2M/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.2h5rlyCti9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:01:01 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 12:01:01 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 12:01:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q9FfmA2y2M/Render', 12:01:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:01:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:01:01 INFO - 'HOME': '/Users/cltbld', 12:01:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:01:01 INFO - 'LOGNAME': 'cltbld', 12:01:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:01 INFO - 'MOZ_NO_REMOTE': '1', 12:01:01 INFO - 'NO_EM_RESTART': '1', 12:01:01 INFO - 'PAGER': '/bin/cat', 12:01:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:01:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:01 INFO - 'PWD': '/builds/slave/test', 12:01:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:01:01 INFO - 'SHELL': '/bin/bash', 12:01:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2h5rlyCti9/Listeners', 12:01:01 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:01:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:01:01 INFO - 'USER': 'cltbld', 12:01:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:01:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:01:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:01 INFO - 'XPC_FLAGS': '0x0', 12:01:01 INFO - 'XPC_SERVICE_NAME': '0', 12:01:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:01:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:01 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 12:01:01 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 12:01:01 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 12:01:01 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 12:01:01 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 12:01:01 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 12:01:01 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 12:01:03 INFO - Downloading mozsystemmonitor-0.0.tar.gz 12:01:04 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 12:01:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 12:01:04 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 12:01:04 INFO - Installing collected packages: mozsystemmonitor 12:01:04 INFO - Running setup.py install for mozsystemmonitor 12:01:04 INFO - Successfully installed mozsystemmonitor 12:01:04 INFO - Cleaning up... 12:01:04 INFO - Return code: 0 12:01:04 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 12:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 12:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:04 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 0x105f95490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f72228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8510490100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb99f0>, '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 0x105c18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eac8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q9FfmA2y2M/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.2h5rlyCti9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:01:04 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 12:01:04 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 12:01:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q9FfmA2y2M/Render', 12:01:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:01:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:01:04 INFO - 'HOME': '/Users/cltbld', 12:01:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:01:04 INFO - 'LOGNAME': 'cltbld', 12:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:04 INFO - 'MOZ_NO_REMOTE': '1', 12:01:04 INFO - 'NO_EM_RESTART': '1', 12:01:04 INFO - 'PAGER': '/bin/cat', 12:01:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:04 INFO - 'PWD': '/builds/slave/test', 12:01:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:01:04 INFO - 'SHELL': '/bin/bash', 12:01:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2h5rlyCti9/Listeners', 12:01:04 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:01:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:01:04 INFO - 'USER': 'cltbld', 12:01:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:01:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:04 INFO - 'XPC_FLAGS': '0x0', 12:01:04 INFO - 'XPC_SERVICE_NAME': '0', 12:01:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:04 INFO - Downloading/unpacking blobuploader==1.2.4 12:01:04 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 12:01:04 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 12:01:04 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 12:01:04 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 12:01:04 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 12:01:04 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 12:01:06 INFO - Downloading blobuploader-1.2.4.tar.gz 12:01:06 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 12:01:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 12:01:06 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01: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 12:01:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 12:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 12:01:07 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 12:01:07 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 12:01:07 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 12:01:07 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 12:01:07 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 12:01:07 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 12:01:07 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 12:01:07 INFO - Downloading docopt-0.6.1.tar.gz 12:01:07 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 12:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 12:01:07 INFO - Installing collected packages: blobuploader, requests, docopt 12:01:07 INFO - Running setup.py install for blobuploader 12:01:07 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 12:01:07 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 12:01:07 INFO - Running setup.py install for requests 12:01:08 INFO - Running setup.py install for docopt 12:01:08 INFO - Successfully installed blobuploader requests docopt 12:01:08 INFO - Cleaning up... 12:01:08 INFO - Return code: 0 12:01:08 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:01:08 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')]} 12:01:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:08 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')]} 12:01:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:08 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 0x105f95490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f72228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8510490100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb99f0>, '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 0x105c18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eac8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q9FfmA2y2M/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.2h5rlyCti9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:01:08 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 12:01:08 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 12:01:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q9FfmA2y2M/Render', 12:01:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:01:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:01:08 INFO - 'HOME': '/Users/cltbld', 12:01:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:01:08 INFO - 'LOGNAME': 'cltbld', 12:01:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:08 INFO - 'MOZ_NO_REMOTE': '1', 12:01:08 INFO - 'NO_EM_RESTART': '1', 12:01:08 INFO - 'PAGER': '/bin/cat', 12:01:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:01:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:08 INFO - 'PWD': '/builds/slave/test', 12:01:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:01:08 INFO - 'SHELL': '/bin/bash', 12:01:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2h5rlyCti9/Listeners', 12:01:08 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:01:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:01:08 INFO - 'USER': 'cltbld', 12:01:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:01:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:01:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:08 INFO - 'XPC_FLAGS': '0x0', 12:01:08 INFO - 'XPC_SERVICE_NAME': '0', 12:01:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:01:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:01:08 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-R42_UZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:01:09 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-I9vZTQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:01:09 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-4kWNxv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:01:09 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-rIv3iQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:01:09 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-tfbYXt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:01:09 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-wjF1SD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:01:09 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-oUqXPl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:01:09 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-GjtKYh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:01:09 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-sZLUwK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:01:09 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-FYayHN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:01:09 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:01:09 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-yCaK8q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:01:10 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-qqBfCK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:01:10 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-XRT2F5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:01:10 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-URrbbH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:01:10 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ZzpVGu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:01:10 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-6aTgoq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:01:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:01:10 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-rklTHh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:01:10 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 12:01:10 INFO - Running setup.py install for manifestparser 12:01:10 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 12:01:10 INFO - Running setup.py install for mozcrash 12:01:10 INFO - Running setup.py install for mozdebug 12:01:11 INFO - Running setup.py install for mozdevice 12:01:11 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 12:01:11 INFO - Installing dm script to /builds/slave/test/build/venv/bin 12:01:11 INFO - Running setup.py install for mozfile 12:01:11 INFO - Running setup.py install for mozhttpd 12:01:11 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 12:01:11 INFO - Running setup.py install for mozinfo 12:01:11 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 12:01:11 INFO - Running setup.py install for mozInstall 12:01:11 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 12:01:11 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 12:01:11 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 12:01:11 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 12:01:11 INFO - Running setup.py install for mozleak 12:01:12 INFO - Running setup.py install for mozlog 12:01:12 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 12:01:12 INFO - Running setup.py install for moznetwork 12:01:12 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 12:01:12 INFO - Running setup.py install for mozprocess 12:01:12 INFO - Running setup.py install for mozprofile 12:01:12 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 12:01:12 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 12:01:12 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 12:01:12 INFO - Running setup.py install for mozrunner 12:01:12 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 12:01:12 INFO - Running setup.py install for mozscreenshot 12:01:12 INFO - Running setup.py install for moztest 12:01:13 INFO - Running setup.py install for mozversion 12:01:13 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 12:01:13 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 12:01:13 INFO - Cleaning up... 12:01:13 INFO - Return code: 0 12:01:13 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:01:13 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')]} 12:01:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:13 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')]} 12:01:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:13 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 0x105f95490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f72228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8510490100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb99f0>, '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 0x105c18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eac8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q9FfmA2y2M/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.2h5rlyCti9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:01:13 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 12:01:13 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 12:01:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q9FfmA2y2M/Render', 12:01:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:01:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:01:13 INFO - 'HOME': '/Users/cltbld', 12:01:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:01:13 INFO - 'LOGNAME': 'cltbld', 12:01:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:13 INFO - 'MOZ_NO_REMOTE': '1', 12:01:13 INFO - 'NO_EM_RESTART': '1', 12:01:13 INFO - 'PAGER': '/bin/cat', 12:01:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:01:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:13 INFO - 'PWD': '/builds/slave/test', 12:01:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:01:13 INFO - 'SHELL': '/bin/bash', 12:01:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2h5rlyCti9/Listeners', 12:01:13 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:01:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:01:13 INFO - 'USER': 'cltbld', 12:01:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:01:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:01:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:13 INFO - 'XPC_FLAGS': '0x0', 12:01:13 INFO - 'XPC_SERVICE_NAME': '0', 12:01:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:01:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 12:01:13 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-aL9ggJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 12:01:13 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)) 12:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 12:01:13 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-VPQhK7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 12:01:13 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)) 12:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 12:01:13 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-X0SOXe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 12:01:13 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)) 12:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 12:01:13 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ZjPcVW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 12:01:13 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)) 12:01:13 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 12:01:14 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-ePA3yU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 12:01:14 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)) 12:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 12:01:14 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-2IquVP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 12:01:14 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)) 12:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 12:01:14 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-y0mt3M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 12:01:14 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)) 12:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 12:01:14 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-nrqa0G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 12:01:14 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)) 12:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 12:01:14 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-CZFY_0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 12:01:14 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)) 12:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 12:01:14 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Mlj1hB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 12:01:14 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)) 12:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 12:01:14 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-UHTteL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 12:01:14 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)) 12:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 12:01:14 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-Re_eKB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 12:01:14 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)) 12:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 12:01:14 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-UawInC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 12:01:14 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)) 12:01:14 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 12:01:14 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-1qZbmX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 12:01:15 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)) 12:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 12:01:15 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-8LOepo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 12:01:15 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)) 12:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 12:01:15 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-8kinij-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 12:01:15 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)) 12:01:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 12:01:15 INFO - Running setup.py (path:/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/pip-v6hDE7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 12:01:15 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)) 12:01:15 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)) 12:01:15 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)) 12:01:15 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)) 12:01:15 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)) 12:01:15 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)) 12:01:15 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 12:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 12:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 12:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 12:01:17 INFO - Downloading blessings-1.5.1.tar.gz 12:01:17 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 12:01:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 12:01:17 INFO - Installing collected packages: blessings 12:01:17 INFO - Running setup.py install for blessings 12:01:17 INFO - Successfully installed blessings 12:01:17 INFO - Cleaning up... 12:01:17 INFO - Return code: 0 12:01:17 INFO - Done creating virtualenv /builds/slave/test/build/venv. 12:01:17 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:01:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:01:18 INFO - Reading from file tmpfile_stdout 12:01:18 INFO - Current package versions: 12:01:18 INFO - blessings == 1.5.1 12:01:18 INFO - blobuploader == 1.2.4 12:01:18 INFO - docopt == 0.6.1 12:01:18 INFO - manifestparser == 1.1 12:01:18 INFO - mozInstall == 1.12 12:01:18 INFO - mozcrash == 0.16 12:01:18 INFO - mozdebug == 0.1 12:01:18 INFO - mozdevice == 0.47 12:01:18 INFO - mozfile == 1.2 12:01:18 INFO - mozhttpd == 0.7 12:01:18 INFO - mozinfo == 0.9 12:01:18 INFO - mozleak == 0.1 12:01:18 INFO - mozlog == 3.0 12:01:18 INFO - moznetwork == 0.27 12:01:18 INFO - mozprocess == 0.22 12:01:18 INFO - mozprofile == 0.27 12:01:18 INFO - mozrunner == 6.11 12:01:18 INFO - mozscreenshot == 0.1 12:01:18 INFO - mozsystemmonitor == 0.0 12:01:18 INFO - moztest == 0.7 12:01:18 INFO - mozversion == 1.4 12:01:18 INFO - psutil == 3.1.1 12:01:18 INFO - requests == 1.2.3 12:01:18 INFO - wsgiref == 0.1.2 12:01:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 12:01: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')]} 12:01:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 12:01:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01: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')]} 12:01:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 12:01:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 12:01:18 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 0x105f95490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105f72228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f8510490100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105eb99f0>, '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 0x105c18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eac8c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q9FfmA2y2M/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.2h5rlyCti9/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 12:01:18 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 12:01:18 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 12:01:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q9FfmA2y2M/Render', 12:01:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:01:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:01:18 INFO - 'HOME': '/Users/cltbld', 12:01:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:01:18 INFO - 'LOGNAME': 'cltbld', 12:01:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:18 INFO - 'MOZ_NO_REMOTE': '1', 12:01:18 INFO - 'NO_EM_RESTART': '1', 12:01:18 INFO - 'PAGER': '/bin/cat', 12:01:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:01:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:18 INFO - 'PWD': '/builds/slave/test', 12:01:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:01:18 INFO - 'SHELL': '/bin/bash', 12:01:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2h5rlyCti9/Listeners', 12:01:18 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:01:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:01:18 INFO - 'USER': 'cltbld', 12:01:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:01:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:01:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:18 INFO - 'XPC_FLAGS': '0x0', 12:01:18 INFO - 'XPC_SERVICE_NAME': '0', 12:01:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:01:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 12:01:18 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)) 12:01:18 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)) 12:01:18 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)) 12:01:18 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)) 12:01:18 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)) 12:01:18 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)) 12:01:18 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)) 12:01:18 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)) 12:01:18 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)) 12:01:18 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)) 12:01:18 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)) 12:01:18 INFO - Cleaning up... 12:01:18 INFO - Return code: 0 12:01:18 INFO - Running post-action listener: _resource_record_post_action 12:01:18 INFO - Running post-action listener: _start_resource_monitoring 12:01:18 INFO - Starting resource monitoring. 12:01:18 INFO - ##### 12:01:18 INFO - ##### Running install step. 12:01:18 INFO - ##### 12:01:18 INFO - Running pre-action listener: _resource_record_pre_action 12:01:18 INFO - Running main action method: install 12:01:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 12:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 12:01:18 INFO - Reading from file tmpfile_stdout 12:01:18 INFO - Detecting whether we're running mozinstall >=1.0... 12:01:18 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 12:01:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 12:01:18 INFO - Reading from file tmpfile_stdout 12:01:18 INFO - Output received: 12:01:18 INFO - Usage: mozinstall [options] installer 12:01:18 INFO - Options: 12:01:18 INFO - -h, --help show this help message and exit 12:01:18 INFO - -d DEST, --destination=DEST 12:01:18 INFO - Directory to install application into. [default: 12:01:18 INFO - "/builds/slave/test"] 12:01:18 INFO - --app=APP Application being installed. [default: firefox] 12:01:18 INFO - mkdir: /builds/slave/test/build/application 12:01:18 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'] 12:01:18 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 12:01:49 INFO - Reading from file tmpfile_stdout 12:01:49 INFO - Output received: 12:01:49 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 12:01:49 INFO - Running post-action listener: _resource_record_post_action 12:01:49 INFO - ##### 12:01:49 INFO - ##### Running run-tests step. 12:01:49 INFO - ##### 12:01:49 INFO - Running pre-action listener: _resource_record_pre_action 12:01:49 INFO - Running main action method: run_tests 12:01:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:01:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:01:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:01:49 INFO - 2015-11-19 12:01:49.372 screenresolution[1643:7754] starting screenresolution argv=screenresolution get 12:01:49 INFO - 2015-11-19 12:01:49.374 screenresolution[1643:7754] Display 0: 1600x1200x32@60 12:01:49 INFO - 2015-11-19 12:01:49.380 screenresolution[1644:7756] starting screenresolution argv=screenresolution list 12:01:49 INFO - Available Modes on Display 0 12:01:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:01:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:01:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:01:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:01:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:01:49 INFO - Intel Iris: 12:01:49 INFO - Chipset Model: Intel Iris 12:01:49 INFO - Type: GPU 12:01:49 INFO - Bus: Built-In 12:01:49 INFO - VRAM (Dynamic, Max): 1536 MB 12:01:49 INFO - Vendor: Intel (0x8086) 12:01:49 INFO - Device ID: 0x0a2e 12:01:49 INFO - Revision ID: 0x0009 12:01:49 INFO - Displays: 12:01:49 INFO - Display: 12:01:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:01:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:01:49 INFO - Display Serial Number: 1600x1200 60 12:01:49 INFO - Main Display: Yes 12:01:49 INFO - Mirror: Off 12:01:49 INFO - Online: Yes 12:01:49 INFO - Rotation: Supported 12:01:49 INFO - Return code: 0 12:01:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 12:01:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 12:01:49 INFO - Python 2.7.3 12:01:49 INFO - Return code: 0 12:01:49 INFO - grabbing minidump binary from tooltool 12:01:49 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')]} 12:01:49 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 0x105eb99f0>, '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 0x105c18db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105eac8c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 12:01:49 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 12:01:49 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 12:01:49 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 12:01:49 INFO - Return code: 0 12:01:49 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 12:01:49 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 12:01:49 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 12:01:49 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 12:01:49 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 12:01:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--webServer', 'localhost'] in /builds/slave/test/build 12:01:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Fx-Team --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0002 --webServer localhost 12:01:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Q9FfmA2y2M/Render', 12:01:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 12:01:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 12:01:49 INFO - 'HOME': '/Users/cltbld', 12:01:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 12:01:49 INFO - 'LOGNAME': 'cltbld', 12:01:49 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 12:01:49 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 12:01:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 12:01:49 INFO - 'MOZ_NO_REMOTE': '1', 12:01:49 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 12:01:49 INFO - 'NO_EM_RESTART': '1', 12:01:49 INFO - 'PAGER': '/bin/cat', 12:01:49 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 12:01:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 12:01:49 INFO - 'PWD': '/builds/slave/test', 12:01:49 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 12:01:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 12:01:49 INFO - 'SHELL': '/bin/bash', 12:01:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.2h5rlyCti9/Listeners', 12:01:49 INFO - 'TMPDIR': '/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/', 12:01:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 12:01:49 INFO - 'USER': 'cltbld', 12:01:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 12:01:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 12:01:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 12:01:49 INFO - 'XPC_FLAGS': '0x0', 12:01:49 INFO - 'XPC_SERVICE_NAME': '0', 12:01:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 12:01:49 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Fx-Team', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0002', '--webServer', 'localhost'] with output_timeout 3600 12:01:49 INFO - mozversion INFO | application_buildid: 20151119095206 12:01:49 INFO - mozversion INFO | application_changeset: 4a5ad4d3df92bda0d3138befc40cbf6084714d79 12:01:49 INFO - mozversion INFO | application_display_name: Nightly 12:01:49 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 12:01:49 INFO - mozversion INFO | application_name: Firefox 12:01:49 INFO - mozversion INFO | application_remotingname: firefox 12:01:49 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/integration/fx-team 12:01:49 INFO - mozversion INFO | application_vendor: Mozilla 12:01:49 INFO - mozversion INFO | application_version: 45.0a1 12:01:49 INFO - mozversion INFO | platform_buildid: 20151119095206 12:01:49 INFO - mozversion INFO | platform_changeset: 4a5ad4d3df92bda0d3138befc40cbf6084714d79 12:01:49 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/integration/fx-team 12:01:49 INFO - mozversion INFO | platform_version: 45.0a1 12:01:49 INFO - 2015-11-19 12:01:49,948 DEBUG : using testdate: 1447963309 12:01:49 INFO - 2015-11-19 12:01:49,948 DEBUG : actual date: 1447963309 12:01:50 INFO - 2015-11-19 12:01:50,439 INFO : starting webserver on 'localhost:49269' 12:01:50 INFO - 2015-11-19 12:01:50,440 INFO : Starting test suite t-yosemite-r7-0002.e 12:01:50 INFO - 2015-11-19 12:01:50,440 INFO : Starting test dromaeo_css 12:01:50 INFO - 2015-11-19 12:01:50,441 DEBUG : operating with platform_type : mac_ 12:01:50 INFO - 2015-11-19 12:01:50,442 INFO : Initialising browser for dromaeo_css test... 12:01:50 INFO - 2015-11-19 12:01:50,454 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpSyHGcv/profile http://localhost:49269/getInfo.html 12:01:53 INFO - 2015-11-19 12:01:53,150 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:01:53 INFO - 2015-11-19 12:01:53,151 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:01:53 INFO - 2015-11-19 12:01:53,151 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:01:53 INFO - 2015-11-19 12:01:53,151 DEBUG : BROWSER_OUTPUT: __metrics 12:01:53 INFO - 2015-11-19 12:01:53,805 INFO : Browser initialized. 12:01:53 INFO - 2015-11-19 12:01:53,805 INFO : Running cycle 1/1 for dromaeo_css test... 12:01:53 INFO - 2015-11-19 12:01:53,805 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpSyHGcv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:02:05 INFO - 2015-11-19 12:02:05,854 DEBUG : BROWSER_OUTPUT: RSS: Main: 237015040 12:02:05 INFO - 2015-11-19 12:02:05,854 DEBUG : BROWSER_OUTPUT: 12:02:55 INFO - 2015-11-19 12:02:55,574 DEBUG : BROWSER_OUTPUT: 1447963375573 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] 12:05:06 INFO - 2015-11-19 12:05:06,761 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49269/tests/dromaeo/cssquery-ext.html) 12:05:07 INFO - 2015-11-19 12:05:07,929 DEBUG : BROWSER_OUTPUT: RSS: Main: 253313024 12:05:07 INFO - 2015-11-19 12:05:07,929 DEBUG : BROWSER_OUTPUT: 12:08:09 INFO - 2015-11-19 12:08:09,816 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-ext.html (next: http://localhost:49269/tests/dromaeo/cssquery-jquery.html) 12:08:10 INFO - 2015-11-19 12:08:10,414 DEBUG : BROWSER_OUTPUT: RSS: Main: 262725632 12:08:10 INFO - 2015-11-19 12:08:10,414 DEBUG : BROWSER_OUTPUT: 12:11:12 INFO - 2015-11-19 12:11:12,006 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49269/tests/dromaeo/cssquery-mootools.html) 12:11:12 INFO - 2015-11-19 12:11:12,598 DEBUG : BROWSER_OUTPUT: RSS: Main: 263225344 12:11:12 INFO - 2015-11-19 12:11:12,598 DEBUG : BROWSER_OUTPUT: 12:14:14 INFO - 2015-11-19 12:14:14,260 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49269/tests/dromaeo/cssquery-prototype.html) 12:14:14 INFO - 2015-11-19 12:14:14,853 DEBUG : BROWSER_OUTPUT: RSS: Main: 265338880 12:14:14 INFO - 2015-11-19 12:14:14,853 DEBUG : BROWSER_OUTPUT: 12:17:17 INFO - 2015-11-19 12:17:17,258 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49269/tests/dromaeo/cssquery-yui.html) 12:17:17 INFO - 2015-11-19 12:17:17,861 DEBUG : BROWSER_OUTPUT: RSS: Main: 268767232 12:17:17 INFO - 2015-11-19 12:17:17,861 DEBUG : BROWSER_OUTPUT: 12:20:20 INFO - 2015-11-19 12:20:20,039 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/dromaeo/cssquery-yui.html (next: http://localhost:49269/tests/dromaeo/cssquery-dojo.html) 12:20:20 INFO - 2015-11-19 12:20:20,287 DEBUG : BROWSER_OUTPUT: RSS: Main: 271667200 12:20:20 INFO - 2015-11-19 12:20:20,288 DEBUG : BROWSER_OUTPUT: 12:20:20 INFO - 2015-11-19 12:20:20,288 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:20:20 INFO - 2015-11-19 12:20:20,288 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:20:20 INFO - 2015-11-19 12:20:20,288 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:20:20 INFO - 2015-11-19 12:20:20,288 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:20:20 INFO - 2015-11-19 12:20:20,289 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3135.9372812543747;3547.0954906498823;3595.1371670799;3603.72972027098;3611.620779818119;5572.498475137242;5848;6001.459868611819;6044.486218671407;6065.211522502074;5963.701814909259;5976.342602313753;5994.8801023979495;6081.726322315495;6099.612447337997;4510.909781804362;5366.570674346062;5458.890822183554;5495.395506494302;5533.474319939599;4903;5505.421930697279;5565.443455654422;5583.4974852263285;5614.606977511576;5229.790808367642;5310.973445132789;5367.865803354908;5429.267048948421;5462.617616766828;5283.07546179417;5288.444713305124;5289.603279754034;5324.041672498949;5467.617266791326;5285.762140703678;5287.709175995319;5301.416844147141;5322.813701520428;5331.333583302087;5514.117741161435;5872.354041055481;5929.75475150219;5964.105384192362;6041.848953776147;6377;6386.201724784402;6395.904061439082;6423.940049891762;6447.194100737408;5393.379761327419;6370.171877655921;6497.93502064978;6536.379043990813;6538.803835884931;6111.724972376253;6131.294901086388;6193.535484838655;6207.472364848948;6221.2845522765465;6571.934280657228;6653.866922661519;6661.2006559213205;6681.064650948871;6697.296783837627;6180.845478862974;6282.591631543935;6297.52768542352;6357;6358.936410635927;6378;6417.679116044273;6451.806445806634;6481.773137940149;6508.316626754123;5594.776208951596;5997.740474500404;6338.859005378984;6386.744530218833;6388.4569811566535;6183.227096612924;6246.812595622138;6319.873602527924;6328.46208072319;6377.5216858735785;5150.896982060338;5158.3552055993005;5161.27742116104;5161.896762064813;5167.044096842096;4625.8843528911375;4629.583337499641;4654.720716756938;4655.255159174583;4714.080754252887;5964.850878728066;6081.452669259788;6103.84740381494;6155.938440615626;6234.875302494015;6384.361563843579;6397;6418.069379939882;6432.356764323624;6442.259140198843;6179.011358182669;6192.690365481708;6206.782762603287;6209.6895155242055;6212.875742485125;5463.7814487420055;5560.555155587544;5567.164925261243;5626.437356264422;5689.374168841424;6549.443297319781;6586.670666466657;6631.535792494479;6641.501887358564;6652.002199670088;6240.871198195646;6447.871042579216;6449.161608990801;6462.5153113515735;6463.450606698483;6501.2523559791225;6502.869942601216;6540.672966351759;6556.114924485133;6583.44040756541;5311.601629877852;6352.650604216812;6364.872702546016;6367.649779262185;6384.553081284265;6258.092576576462;6326.905096423466;6442.645654489048;6469.708863101077;6472.093906853139;5055.848324550269;6092.268927728701;6140.872371569611;6271.498280137487;6286.465650419766;6306.61254524004;6309.779157729457;6314.273858506331;6330.398612132024;6341.207349081365;6034.034554471264;6127.372786728296;6146.815595532141;6247.437730604267;6302.873942521215;5092.828649410582;6338.936610633835;6341.175647165839;6341.207349081365;6355.586886852339;6210.627362358273;6251.156093927443;6259.906101408392;6306.842328941813;6309.558330916975 12:20:20 INFO - 2015-11-19 12:20:20,292 DEBUG : BROWSER_OUTPUT: |1;ext.html;566.9177969194467;567.9176519404689;573.7543428014013;608.5922431970579;613.3866133866137;32544;40268.1946361073;40733;40775.796121019426;40848.79575602118;44618.55381446185;44866.878328041814;44965.55034449654;45246.09507809842;45328.546714532844;9977.40135591865;10082.395056296646;10178.643747468841;10200.693979180636;10201.132903703194;9953;10043.19654427644;10060.295779295453;10063.647772327933;10071.848922266172;9975.75060623483;10043.447610381427;10096.09135177834;10098.444585547792;10115.949420252888;9964.800703985917;10042.096211340979;10054.09513143817;10065.69802905914;10078.344907580984;9802;9959;9962.800743985152;9965.601375945025;10021.849672254923;42666.360004599956;42790;42998.57001429977;43206.35190472146;43270.35094473585;3245.5618491503583;3263.863727733422;3304.9173770655684;3497.3704733148024;3613.385724426854;28878.71121288802;29857.552136717968;30011.699883001107;30307;30349.24126896823;2600.8569528675916;2620.2008387441824;2622.7246139155304;2638.28766233116;2660.361513236809;423678;484014.99999999645;494669;494722;495288;56861;57910.71044644834;70824.64587677132;71156;71663.6416817923;71832;71863;72022;72267;72494.63752681308;16583.17084145788;16961.91519042397;16964;17079.658406831793;17140;12656.43046062911;12838.67903302425;12884.484620615258;12906.612801615967;13035.348232588332;18793.530161746065;21208.469788255417;21646.567068658853;21890.90545472752;21958.560828783335;7652;7755.914172015922;8638.56807159652;8889.73330800077;9042.819143617091;724.5145752345941;898.8786513820551;965.4545181972304;1069.2996087562658;1077.7144056824948;29722.851385743365;29758.85120574383;29915.850420748193;30439.543406848916;30513.69486305153;1046.2414749306693;1114.0753174864842;1116.2576886370473;1181.1554738362113;1187.0681515010674;15271.847281527043;15476.613084672974;15625.374985000473;15761;15897.364105435885;524896;557761;558311;563358;564439;45400.54599454029;60299.39700603025;60490.18529444124;60680.69659651673;61112.38887611067;1390.5897760160776;1405.2552147361914;1407.6973450708147;1424.9287535623178;1441.128117488925;28487.43025139527;29735;29758.25604359908;30297.848510758187;30425;53658.463415365346;53796.46203538071;53821.19268211058;53882.922341553734;54195.729021354644;499160;499295;501400;502560;505773;34005.809796657;34906.65093349136;34965;35017.94946151518;35019.64980350266;43787.562124378346;44331;45573;45944.7702761484;45962.540374595825;38742.61257387503;38969;39012.219755604165;39130.80434597809;39266.60733392744;37764.35649504618;38149;38878.41682374823;38981;38993.8050309758;37034.629653703116;37662.623373767005;38242.426363605126;38383.80808095942;38399.616003839605;28749.856250718614;31399.529007064455;33542.99371018873;34008.3198336027;34480.96557103291;24902.75097249077;25208.495830082928;25366.873165634053;25573.104941326965;25674.871625641754 12:20:20 INFO - 2015-11-19 12:20:20,293 DEBUG : BROWSER_OUTPUT: |2;jquery.html;352.68258567289445;353.688753896571;353.720560757002;353.9964600353996;356.87687747727034;16111.758323625156;17892.194851231692;19768.60462790745;20068.197272109097;20679.689804652942;12323.198992065532;12529.68675783106;12611.18027328223;12616.432260548274;19940.70088948667;4226;4552.995023284625;4795.736234507101;4799.976000119995;4809.639277054235;4769.737664428455;4974.427940786802;5064.848054558351;5101.846944591668;5113.181890897457;4926.802927882881;4989.326440930482;5044.520770526794;5054.797808087672;5133.358330208724;5090.77091530882;5099.311592934943;5103.872403189913;5121.283020377132;5129.769160387754;4304.268274393329;4306.633936115434;4329.740215587043;4337.0458499130145;4344.283193273138;13532.052756307063;13550.525731599346;13902.860971390257;13970.371333289924;14058.648533786634;1919.5201199700075;1922.1062206074243;1930.903454827267;2011.1352118589;2015.3752336775647;9791.706248812547;9880;9924.31286681266;10089.243306752023;10197.89802101977;1428.3429622373721;1592.920353982308;1612.11333766428;1629.8370162983726;1668.7413450915128;93315.53342233246;97291.54062688994;98079.0192098077;98830.99999999929;99377;6847.589144651337;6855.108835851307;6882.5870447773295;6904.758333458305;6953.652317384111;7707.267809558083;7729.304362607392;7734.5359278443475;7762.184970578121;7806;5746.080627099644;5764.74058667361;5777.6822274775295;5789.565782566325;5789.797357092481;6234.470070044006;6253.96873015632;6259.061140828912;6271.216097987752;6297.559170858088;2519.4961007798515;2989.671136175019;3019.686436400173;3022.1386904732044;3056.3581647853757;1080.702806728156;1084.3656460970262;1085.0722632149557;1132.365875109941;1135.0465608888574;424.35921758145423;425.2600475173238;436.5808823529384;466.02368038958326;469.610223514489;11285.492152853141;12584.37078146089;12585.87414125847;12718.236905785683;12760.106792524433;464.1969392950215;470.2335193634354;473.7844280852204;486.67392846792023;504.48794473609314;6598.637074960827;6621.536492445579;6649.102371179829;6696.0960270362875;6728.730850766013;677098.6145069243;704554;738625;761690;772140;93211.07705844943;119461;119629;120037;123669;515.4561937156336;521.2259794205677;522.088954773922;542.7232111623022;543.9728013599304;11595.884041159481;11817;11941.22382045199;11976.28142311464;12027;46874.53125468702;48007.519924800305;49161.754191228814;51188;51335;49411.50588494069;52504.42486725404;53701.731491342296;67297.32702672911;68098;6331.525135614939;6489;6551.148350714377;6560.639164845788;6573.3098024706715;11600.723920368922;11867.109966752356;12645.304508252135;12718.236905785312;12795.168314059556;10222.13111885498;10374.910634383583;10907.945460272966;11189.944050279697;11313.71715707114;10880.455977201267;10906.236563440483;10916.672499825017;11028.338299702044;11063.668089957315;10263.7434064149;10611.363318200933;11430;11451.828222576502;11492.367919764492;5626.381098079126;6396.968015159894;6479.416852483299;6480.902786458301;6536.379043990813;10945.562177512811;10977.341359518454;11231.38227397501;11237.943810280896;11297.7740445189 12:20:20 INFO - 2015-11-19 12:20:20,296 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1394.62345166805;1446.1756798624783;1633.5344426838353;1907.6947688369864;1929.1415320182525;7712.961435192816;7838.372930165588;7875.779254215591;8136.593170341482;8244.134365891578;8180.954761309673;8317.209865062809;8395.832083358344;8408.327333813295;8451.070382257947;2337.2988103568946;2358.1157066100213;2372.822038347122;2376.5009348036933;2377.3699969508093;2334.7665233476687;2345.2260753951155;2387.6657267982496;2399.8680072596;2401.339631601315;2341.8477798943013;2364.172539611131;2393.6768536247646;2404.903803847853;2414.5533076380925;2300.183434880627;2314.2941402872116;2324.93025209244;2329.6272596384665;2337.567550003238;2378.8334816562847;2411.855288682667;2425.1754403502896;2428.647846062311;2434.330559096245;7505.924940750577;8237.052738935039;8289.917100828974;8327.20891515305;8392.916070839274;4696.553827386427;5135.537801597874;5222.060029194743;5232.633715639907;5251.343582052244;3221.4362486564755;3428.971308607408;3438.1060924159647;3478.3738926993133;3502.5271588335504;1042.7914417116608;1060.5598676549223;1067.9199060070525;1089.5042755546208;1089.9509522071526;10645.148388129008;10728;10755.462226888703;10766.40784756838;10880.891191088067;4648.604868586141;4668.439787225555;4683.110209060268;4730.574248317668;4738.2418812990445;9712.951435242778;9730.464824434583;9731.90268097324;9768.120869121813;9775.804483910424;5161.122609156452;5167.612429067835;5200.037992971313;5208.921866172011;5216.895662086737;4697.906041879143;4713.57577817998;4745.217039188564;4751.453582838018;4754.02542478791;3725.5529336479253;3758.1356288053903;3771.26460340231;3777.3956167013694;3792.886213413602;1097.9945100274447;1246.6696325473756;1257.792464243408;1262.5265525427965;1270.1870802686287;1243.2229856339789;1247.25788156047;1271.7011502296953;1287.3434548380394;1298.3702904091508;7793.636113680083;7805.609719514002;7846.17615150401;8027.438079334391;8028.076771171273;1195.5277665322149;1200.2078628105407;1202.6331968749616;1218.2203389830515;1223.3883058470765;6004.729787159588;6058.182145410401;6079.969600151971;6133.601315914451;6141.07883817431;9510.42937423743;10018.899811001796;10117.848232276521;10155.136813370798;10177.18582513397;9435.716928492157;9725.173360264456;9893;9903.950480247697;9941.906390297061;7801.258880406353;7804.68781248755;7842.490238134503;7910.762677119696;7957.164497727771;7378.483506154517;7472.626368681435;7495.550266983998;7814.296713295831;7820.608969551614;8830.911690883266;8947.105289471001;9012.963509196265;9031.412958157698;9060.728178154666;8695.652173912973;8882.289416846766;8923.553822308988;9194.034626364135;9276.397034192756;7303.233160518069;7328.157261914948;7377.926220737724;7398.408127349907;7409.962950185431;7982.8802567960365;8005.719799806979;8006.519608823489;8014.238647328494;8019.6391162398995;6483.513736469689;7407.111146662435;7504.924950750641;7555.206703296075;7659.463837531543;7252.673629686571;7408.370288525536;7415.147258065392;7430.4798664093;7486.326230639051;7419.183889772229;7541.660625271767;7546.396288297033;7549.207333230152;7566.546007239584;6790.7623233186605;6837.897431538431;6851.725930962705;6853.931460685529;6866.210385805696;6842.897356539556;6902.896456553256;6914.274001229798;6966.1988871280455;6966.686499107451 12:20:20 INFO - 2015-11-19 12:20:20,298 DEBUG : BROWSER_OUTPUT: |4;prototype.html;269.34683392772524;321.3973799126638;322.58386681181275;331.966803319668;334.3196594929319;6963.199232088311;6969.477289203311;7114.822129446767;7187.245339239376;7192.460565457585;6868.244493105767;6959.408450281732;7025.964870175642;7029.332213439728;7056;5095.286659867622;5104.05574968632;5104.84685459435;5109.923351149736;5125.333706618135;4911.950880491185;5090.007448547534;5096.592272618182;5107.055194788976;5120.871978200556;5004.899902001957;5015.7492125393765;5023.146065168912;5025.974870125644;5053.216751403538;5007.84976450707;5012.699238045729;5039.4708555601865;5043.722595257278;5050.393952725678;4161.313383291753;4229.111886503838;4239.236937351276;4239.682023848224;4243.957560424387;6663.100481434993;6670.766523171715;6675.732970681167;6691.464682825411;6704.329567043305;5879.118132280149;5948.791792287249;5949.286085669747;5959.344472108108;6015.849603759897;7196.2443943385715;7450.552966821954;7463.253674632493;7472.813179670552;7488.887666684949;4346.6522678185665;4367.432233809616;4725.574698277137;4756.6908150970075;4759.214729569617;6828.829279268009;7873.212678732139;7970.800729981739;8001.479903806292;8013.7195198168365;4679.227927391942;4817.421909370828;4818.060478206786;4846;4851.975740121276;4152.418661387348;4848.933234688363;4904.362432883774;4920.114379411669;4935.703857768545;5900.852478687982;5929.288485381781;5954.434328738763;5970.820875373745;5981.431763982502;6089.634621922699;6154.5384096192965;7564;7580.3556697681315;7589.241075892477;1636.7053930292661;1712.8886622369507;1713.0406972095666;1715.1424287856073;1720.32047341302;1064.0264158295229;1081.0972837680467;1082.6156714366443;1088.983665245022;1089.6022951622758;7017.508774385846;7047.753328633473;7049.541779784297;7049.718011279491;7053.153621565445;7813.335866451302;7816.335611472975;7831.6867325307485;7833;7846.764597062097;6810.421114205249;7007.369336759716;7079.1858936223;7080.256573059857;7081.079459670313;4045.19096180765;4130.091379896418;4151.169766046803;4151.27352713274;4153.252414565407;8056.959715201387;8244;8251.669933202726;8272.924519812386;8283.58582070906;8192.795180120545;8210.835783284301;8214.712485062993;8215.794605134919;8259.8348033039;6635.568688035359;7920.960395198103;8281.668733250723;8303.086660467343;8310.127436619068;7928.603569821601;7934.722284720007;7937.206279372017;7941.722039728582;7965;7532.510386824839;7748.147703752696;7836.412269079956;7845.293923546908;7857.449978501679;6293;7742.109657389472;8022.157673444204;8248.54632995191;8350.665973360998;3972.2849887020616;4827.348307978518;4831.396075490564;4833.879153021203;4854.68444551103;7695.92304076952;7906.853506241678;7919.208079192034;7925;7941.483803552751;7594.772156835304;7622.504537205064;7622.58075805836;7647.120581133018;7650.961745191461;7386.482946193715;7573.848523029619;7596;7598.506097103671;7604.581748003913;6632.270450250372;6907.13660792401;7407.1852096268285;7456.664450099867;7468.701251949861;6139.785107521216;7586.962065189638;7633.618319083913;7641.044869391326;7647.502912310682;7180.660992638239;7456.440766942393;7466.178720340867;7475.813104672427;7479.439042071976 12:20:20 INFO - 2015-11-19 12:20:20,299 DEBUG : BROWSER_OUTPUT: |5;yui.html;656.7504348347627;710.6517806274924;728.4099879097931;772.2200577416809;790.3321693169273;11946.880531194685;12040.51837926484;12075;12082.33547154906;12123.33321667308;14137.646558836033;14296;15619.765703514457;15812.683746325067;15842.366305347772;683.3337495941468;748.8127968007998;947.4836214263244;952.4095061062151;954.9522523873778;734.6436978065634;931.2456909902967;931.9720408387759;944.4239014201331;945.6737425588161;938.4556956964944;949.3876449689981;952.3190918493276;957.4351132831628;967.569431602937;923.4643906534194;939.4222553129845;940.3558562384754;946.517276189145;950.3585080070959;696.314130581377;697.4699228586311;701.8420855307565;705.1960764728213;706.2196273118182;14744.336504857307;14754.409823607042;14823.555293341216;14825.70348593022;14846.554603361916;9105;9806.215502759762;10159.288849780518;10541.525631346607;10926.562937482491;9595.712128636153;9615.711528654152;9628.277879159092;9919.206463482904;9931.20550355977;3103.4568950433586;3203.3112880730755;3206.3106432116974;3207.711305982473;3266.8203248821305;69247;70399.29600703978;71999.28000719978;72127.63936180338;72276.55446891085;7256.854862902818;7294.9270507295305;7298.525595836254;7308.634568271672;7345.412367010733;12722.427490762939;12745.553905613258;12765.936170319275;12783;12813;5941.435563621449;6565.573237739532;6628.5691430056895;6827.590344579341;6830.112085428863;4095.996480862208;4105.938410923838;4138.8551400700835;4211.073563815956;4380.78096095194;3167.7307428868803;3188.3782662380613;3199.6800319967815;3204.0548038328748;3205.7916235444623;485.65518481878263;503.3833553896521;506.35186960690373;519.1667373864892;521.705236541353;468.7304799740163;497.28887690602784;499.16140883316376;515.8281165850541;531.7766538054027;8598.269147122439;8679.218870301704;8683.956580217058;8806.119388061143;8883.200511953955;499.4406264983242;524.7114087252072;525.2226704477395;526.8208809004957;588.9957622254132;3393.4909763535666;4027.959720402817;4033.3748269018347;4106.240345536085;4209.284421648327;93222;93883;94644;95296.52351738197;103537.48231258795;77948;78780.60609696915;81076.18923810804;81158.18841811625;81300.59349703214;73910.26089739142;75074.87387689188;75318;75387.62306188434;76525.61737191278;9078.954605227196;9129.634814607341;9136.817263654822;9214.170724634814;9230.815383692423;50255;51049.72375690637;51089.23366149436;51477;52141.26446090851;52660.683482913235;65534.34465655282;69849;76301;78264.60867695625;6579.934200657932;7933.3653307734085;7965.681372745257;8072.556009419538;8178.059523154913;12166.75666486683;12486.313252771184;12552.623421297376;12662.493500259887;13099.541516047273;11668;11746;12183.208091474025;12224.266544007389;12458.252504849737;11391.601293954673;11633.76732465329;11857.288562686266;12046.156769026084;12520.373981301082;10363.610182872779;10437.425941573287;11414.972652461318;11517.481713323088;12431.813522796985;9130.360874738704;9297.442153470813;9449.669261575811;9491.66779162726;9665.806683866143;8731.388802783744;8787.692430764893;9144.954275228582;9163.633454661738;10032.197424206191 12:20:20 INFO - 2015-11-19 12:20:20,299 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:20:20 INFO - 2015-11-19 12:20:20,299 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:20:20 INFO - 2015-11-19 12:20:20,299 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,326 12:20:20 INFO - 2015-11-19 12:20:20,299 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:20:20 INFO - 2015-11-19 12:20:20,299 DEBUG : BROWSER_OUTPUT: __startTimestamp1447964420285__endTimestamp 12:20:20 INFO - 2015-11-19 12:20:20,300 DEBUG : BROWSER_OUTPUT: 12:20:20 INFO - 2015-11-19 12:20:20,300 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:20:20 INFO - 2015-11-19 12:20:20,300 DEBUG : BROWSER_OUTPUT: Number of tests: 6 12:20:20 INFO - 2015-11-19 12:20:20,300 DEBUG : BROWSER_OUTPUT: 12:20:20 INFO - 2015-11-19 12:20:20,301 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5931.13 Median:6206.78 stddev:673.25 (10.8%) stddev-sans-first:638.61 12:20:20 INFO - 2015-11-19 12:20:20,301 DEBUG : BROWSER_OUTPUT: Values: 3135.9 3547.1 3595.1 3603.7 3611.6 5572.5 5848.0 6001.5 6044.5 6065.2 5963.7 5976.3 5994.9 6081.7 6099.6 4510.9 5366.6 5458.9 5495.4 5533.5 4903.0 5505.4 5565.4 5583.5 5614.6 5229.8 5311.0 5367.9 5429.3 5462.6 5283.1 5288.4 5289.6 5324.0 5467.6 5285.8 5287.7 5301.4 5322.8 5331.3 5514.1 5872.4 5929.8 5964.1 6041.8 6377.0 6386.2 6395.9 6423.9 6447.2 5393.4 6370.2 6497.9 6536.4 6538.8 6111.7 6131.3 6193.5 6207.5 6221.3 6571.9 6653.9 6661.2 6681.1 6697.3 6180.8 6282.6 6297.5 6357.0 6358.9 6378.0 6417.7 6451.8 6481.8 6508.3 5594.8 5997.7 6338.9 6386.7 6388.5 6183.2 6246.8 6319.9 6328.5 6377.5 5150.9 5158.4 5161.3 5161.9 5167.0 4625.9 4629.6 4654.7 4655.3 4714.1 5964.9 6081.5 6103.8 6155.9 6234.9 6384.4 6397.0 6418.1 6432.4 6442.3 6179.0 6192.7 6206.8 6209.7 6212.9 5463.8 5560.6 5567.2 5626.4 5689.4 6549.4 6586.7 6631.5 6641.5 6652.0 6240.9 6447.9 6449.2 6462.5 6463.5 6501.3 6502.9 6540.7 6556.1 6583.4 5311.6 6352.7 6364.9 6367.6 6384.6 6258.1 6326.9 6442.6 6469.7 6472.1 5055.8 6092.3 6140.9 6271.5 6286.5 6306.6 6309.8 6314.3 6330.4 6341.2 6034.0 6127.4 6146.8 6247.4 6302.9 5092.8 6338.9 6341.2 6341.2 6355.6 6210.6 6251.2 6259.9 6306.8 6309.6 12:20:20 INFO - 2015-11-19 12:20:20,301 DEBUG : BROWSER_OUTPUT: 12:20:20 INFO - 2015-11-19 12:20:20,301 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:66340.34 Median:37348.63 stddev:136272.59 (364.9%) stddev-sans-first:136565.39 12:20:20 INFO - 2015-11-19 12:20:20,303 DEBUG : BROWSER_OUTPUT: Values: 566.9 567.9 573.8 608.6 613.4 32544.0 40268.2 40733.0 40775.8 40848.8 44618.6 44866.9 44965.6 45246.1 45328.5 9977.4 10082.4 10178.6 10200.7 10201.1 9953.0 10043.2 10060.3 10063.6 10071.8 9975.8 10043.4 10096.1 10098.4 10115.9 9964.8 10042.1 10054.1 10065.7 10078.3 9802.0 9959.0 9962.8 9965.6 10021.8 42666.4 42790.0 42998.6 43206.4 43270.4 3245.6 3263.9 3304.9 3497.4 3613.4 28878.7 29857.6 30011.7 30307.0 30349.2 2600.9 2620.2 2622.7 2638.3 2660.4 423678.0 484015.0 494669.0 494722.0 495288.0 56861.0 57910.7 70824.6 71156.0 71663.6 71832.0 71863.0 72022.0 72267.0 72494.6 16583.2 16961.9 16964.0 17079.7 17140.0 12656.4 12838.7 12884.5 12906.6 13035.3 18793.5 21208.5 21646.6 21890.9 21958.6 7652.0 7755.9 8638.6 8889.7 9042.8 724.5 898.9 965.5 1069.3 1077.7 29722.9 29758.9 29915.9 30439.5 30513.7 1046.2 1114.1 1116.3 1181.2 1187.1 15271.8 15476.6 15625.4 15761.0 15897.4 524896.0 557761.0 558311.0 563358.0 564439.0 45400.5 60299.4 60490.2 60680.7 61112.4 1390.6 1405.3 1407.7 1424.9 1441.1 28487.4 29735.0 29758.3 30297.8 30425.0 53658.5 53796.5 53821.2 53882.9 54195.7 499160.0 499295.0 501400.0 502560.0 505773.0 34005.8 34906.7 34965.0 35017.9 35019.6 43787.6 44331.0 45573.0 45944.8 45962.5 38742.6 38969.0 39012.2 39130.8 39266.6 37764.4 38149.0 38878.4 38981.0 38993.8 37034.6 37662.6 38242.4 38383.8 38399.6 28749.9 31399.5 33543.0 34008.3 34481.0 24902.8 25208.5 25366.9 25573.1 25674.9 12:20:20 INFO - 2015-11-19 12:20:20,303 DEBUG : BROWSER_OUTPUT: 12:20:20 INFO - 2015-11-19 12:20:20,303 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:35215.52 Median:2508.60 stddev:120717.93 (4812.2%) stddev-sans-first:121028.19 12:20:20 INFO - 2015-11-19 12:20:20,304 DEBUG : BROWSER_OUTPUT: Values: 352.7 353.7 353.7 354.0 356.9 16111.8 17892.2 19768.6 20068.2 20679.7 12323.2 12529.7 12611.2 12616.4 19940.7 4226.0 4553.0 4795.7 4800.0 4809.6 4769.7 4974.4 5064.8 5101.8 5113.2 4926.8 4989.3 5044.5 5054.8 5133.4 5090.8 5099.3 5103.9 5121.3 5129.8 4304.3 4306.6 4329.7 4337.0 4344.3 13532.1 13550.5 13902.9 13970.4 14058.6 1919.5 1922.1 1930.9 2011.1 2015.4 9791.7 9880.0 9924.3 10089.2 10197.9 1428.3 1592.9 1612.1 1629.8 1668.7 93315.5 97291.5 98079.0 98831.0 99377.0 6847.6 6855.1 6882.6 6904.8 6953.7 7707.3 7729.3 7734.5 7762.2 7806.0 5746.1 5764.7 5777.7 5789.6 5789.8 6234.5 6254.0 6259.1 6271.2 6297.6 2519.5 2989.7 3019.7 3022.1 3056.4 1080.7 1084.4 1085.1 1132.4 1135.0 424.4 425.3 436.6 466.0 469.6 11285.5 12584.4 12585.9 12718.2 12760.1 464.2 470.2 473.8 486.7 504.5 6598.6 6621.5 6649.1 6696.1 6728.7 677098.6 704554.0 738625.0 761690.0 772140.0 93211.1 119461.0 119629.0 120037.0 123669.0 515.5 521.2 522.1 542.7 544.0 11595.9 11817.0 11941.2 11976.3 12027.0 46874.5 48007.5 49161.8 51188.0 51335.0 49411.5 52504.4 53701.7 67297.3 68098.0 6331.5 6489.0 6551.1 6560.6 6573.3 11600.7 11867.1 12645.3 12718.2 12795.2 10222.1 10374.9 10907.9 11189.9 11313.7 10880.5 10906.2 10916.7 11028.3 11063.7 10263.7 10611.4 11430.0 11451.8 11492.4 5626.4 6397.0 6479.4 6480.9 6536.4 10945.6 10977.3 11231.4 11237.9 11297.8 12:20:20 INFO - 2015-11-19 12:20:20,304 DEBUG : BROWSER_OUTPUT: 12:20:20 INFO - 2015-11-19 12:20:20,304 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5797.92 Median:6069.08 stddev:2964.03 (48.8%) stddev-sans-first:2953.86 12:20:20 INFO - 2015-11-19 12:20:20,306 DEBUG : BROWSER_OUTPUT: Values: 1394.6 1446.2 1633.5 1907.7 1929.1 7713.0 7838.4 7875.8 8136.6 8244.1 8181.0 8317.2 8395.8 8408.3 8451.1 2337.3 2358.1 2372.8 2376.5 2377.4 2334.8 2345.2 2387.7 2399.9 2401.3 2341.8 2364.2 2393.7 2404.9 2414.6 2300.2 2314.3 2324.9 2329.6 2337.6 2378.8 2411.9 2425.2 2428.6 2434.3 7505.9 8237.1 8289.9 8327.2 8392.9 4696.6 5135.5 5222.1 5232.6 5251.3 3221.4 3429.0 3438.1 3478.4 3502.5 1042.8 1060.6 1067.9 1089.5 1090.0 10645.1 10728.0 10755.5 10766.4 10880.9 4648.6 4668.4 4683.1 4730.6 4738.2 9713.0 9730.5 9731.9 9768.1 9775.8 5161.1 5167.6 5200.0 5208.9 5216.9 4697.9 4713.6 4745.2 4751.5 4754.0 3725.6 3758.1 3771.3 3777.4 3792.9 1098.0 1246.7 1257.8 1262.5 1270.2 1243.2 1247.3 1271.7 1287.3 1298.4 7793.6 7805.6 7846.2 8027.4 8028.1 1195.5 1200.2 1202.6 1218.2 1223.4 6004.7 6058.2 6080.0 6133.6 6141.1 9510.4 10018.9 10117.8 10155.1 10177.2 9435.7 9725.2 9893.0 9904.0 9941.9 7801.3 7804.7 7842.5 7910.8 7957.2 7378.5 7472.6 7495.6 7814.3 7820.6 8830.9 8947.1 9013.0 9031.4 9060.7 8695.7 8882.3 8923.6 9194.0 9276.4 7303.2 7328.2 7377.9 7398.4 7410.0 7982.9 8005.7 8006.5 8014.2 8019.6 6483.5 7407.1 7504.9 7555.2 7659.5 7252.7 7408.4 7415.1 7430.5 7486.3 7419.2 7541.7 7546.4 7549.2 7566.5 6790.8 6837.9 6851.7 6853.9 6866.2 6842.9 6902.9 6914.3 6966.2 6966.7 12:20:20 INFO - 2015-11-19 12:20:20,306 DEBUG : BROWSER_OUTPUT: 12:20:20 INFO - 2015-11-19 12:20:20,306 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:6108.55 Median:6961.30 stddev:2013.96 (28.9%) stddev-sans-first:1971.35 12:20:20 INFO - 2015-11-19 12:20:20,307 DEBUG : BROWSER_OUTPUT: Values: 269.3 321.4 322.6 332.0 334.3 6963.2 6969.5 7114.8 7187.2 7192.5 6868.2 6959.4 7026.0 7029.3 7056.0 5095.3 5104.1 5104.8 5109.9 5125.3 4912.0 5090.0 5096.6 5107.1 5120.9 5004.9 5015.7 5023.1 5026.0 5053.2 5007.8 5012.7 5039.5 5043.7 5050.4 4161.3 4229.1 4239.2 4239.7 4244.0 6663.1 6670.8 6675.7 6691.5 6704.3 5879.1 5948.8 5949.3 5959.3 6015.8 7196.2 7450.6 7463.3 7472.8 7488.9 4346.7 4367.4 4725.6 4756.7 4759.2 6828.8 7873.2 7970.8 8001.5 8013.7 4679.2 4817.4 4818.1 4846.0 4852.0 4152.4 4848.9 4904.4 4920.1 4935.7 5900.9 5929.3 5954.4 5970.8 5981.4 6089.6 6154.5 7564.0 7580.4 7589.2 1636.7 1712.9 1713.0 1715.1 1720.3 1064.0 1081.1 1082.6 1089.0 1089.6 7017.5 7047.8 7049.5 7049.7 7053.2 7813.3 7816.3 7831.7 7833.0 7846.8 6810.4 7007.4 7079.2 7080.3 7081.1 4045.2 4130.1 4151.2 4151.3 4153.3 8057.0 8244.0 8251.7 8272.9 8283.6 8192.8 8210.8 8214.7 8215.8 8259.8 6635.6 7921.0 8281.7 8303.1 8310.1 7928.6 7934.7 7937.2 7941.7 7965.0 7532.5 7748.1 7836.4 7845.3 7857.4 6293.0 7742.1 8022.2 8248.5 8350.7 3972.3 4827.3 4831.4 4833.9 4854.7 7695.9 7906.9 7919.2 7925.0 7941.5 7594.8 7622.5 7622.6 7647.1 7651.0 7386.5 7573.8 7596.0 7598.5 7604.6 6632.3 6907.1 7407.2 7456.7 7468.7 6139.8 7587.0 7633.6 7641.0 7647.5 7180.7 7456.4 7466.2 7475.8 7479.4 12:20:20 INFO - 2015-11-19 12:20:20,308 DEBUG : BROWSER_OUTPUT: 12:20:20 INFO - 2015-11-19 12:20:20,308 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:17887.59 Median:6604.25 stddev:26082.82 (394.9%) stddev-sans-first:26123.90 12:20:20 INFO - 2015-11-19 12:20:20,309 DEBUG : BROWSER_OUTPUT: Values: 656.8 710.7 728.4 772.2 790.3 11946.9 12040.5 12075.0 12082.3 12123.3 14137.6 14296.0 15619.8 15812.7 15842.4 683.3 748.8 947.5 952.4 955.0 734.6 931.2 932.0 944.4 945.7 938.5 949.4 952.3 957.4 967.6 923.5 939.4 940.4 946.5 950.4 696.3 697.5 701.8 705.2 706.2 14744.3 14754.4 14823.6 14825.7 14846.6 9105.0 9806.2 10159.3 10541.5 10926.6 9595.7 9615.7 9628.3 9919.2 9931.2 3103.5 3203.3 3206.3 3207.7 3266.8 69247.0 70399.3 71999.3 72127.6 72276.6 7256.9 7294.9 7298.5 7308.6 7345.4 12722.4 12745.6 12765.9 12783.0 12813.0 5941.4 6565.6 6628.6 6827.6 6830.1 4096.0 4105.9 4138.9 4211.1 4380.8 3167.7 3188.4 3199.7 3204.1 3205.8 485.7 503.4 506.4 519.2 521.7 468.7 497.3 499.2 515.8 531.8 8598.3 8679.2 8684.0 8806.1 8883.2 499.4 524.7 525.2 526.8 589.0 3393.5 4028.0 4033.4 4106.2 4209.3 93222.0 93883.0 94644.0 95296.5 103537.5 77948.0 78780.6 81076.2 81158.2 81300.6 73910.3 75074.9 75318.0 75387.6 76525.6 9079.0 9129.6 9136.8 9214.2 9230.8 50255.0 51049.7 51089.2 51477.0 52141.3 52660.7 65534.3 69849.0 76301.0 78264.6 6579.9 7933.4 7965.7 8072.6 8178.1 12166.8 12486.3 12552.6 12662.5 13099.5 11668.0 11746.0 12183.2 12224.3 12458.3 11391.6 11633.8 11857.3 12046.2 12520.4 10363.6 10437.4 11415.0 11517.5 12431.8 9130.4 9297.4 9449.7 9491.7 9665.8 8731.4 8787.7 9145.0 9163.6 10032.2 12:20:20 INFO - 2015-11-19 12:20:20,309 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:20:20 INFO - 2015-11-19 12:20:20,309 DEBUG : BROWSER_OUTPUT: 12:20:20 INFO - 2015-11-19 12:20:20,702 INFO : Browser exited with error code: 0 12:20:20 INFO - 2015-11-19 12:20:20,726 INFO : Completed test dromaeo_css (00:18:30) 12:20:20 INFO - 2015-11-19 12:20:20,727 INFO : Starting test kraken 12:20:20 INFO - 2015-11-19 12:20:20,727 DEBUG : operating with platform_type : mac_ 12:20:20 INFO - 2015-11-19 12:20:20,727 INFO : Initialising browser for kraken test... 12:20:20 INFO - 2015-11-19 12:20:20,739 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpPNS7ZO/profile http://localhost:49269/getInfo.html 12:20:23 INFO - 2015-11-19 12:20:23,400 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:20:23 INFO - 2015-11-19 12:20:23,400 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:20:23 INFO - 2015-11-19 12:20:23,400 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:20:23 INFO - 2015-11-19 12:20:23,400 DEBUG : BROWSER_OUTPUT: __metrics 12:20:23 INFO - 2015-11-19 12:20:23,977 INFO : Browser initialized. 12:20:23 INFO - 2015-11-19 12:20:23,978 INFO : Running cycle 1/1 for kraken test... 12:20:23 INFO - 2015-11-19 12:20:23,978 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpPNS7ZO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:20:35 INFO - 2015-11-19 12:20:35,884 DEBUG : BROWSER_OUTPUT: RSS: Main: 235958272 12:20:35 INFO - 2015-11-19 12:20:35,885 DEBUG : BROWSER_OUTPUT: 12:20:38 INFO - 2015-11-19 12:20:38,437 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection) 12:20:39 INFO - 2015-11-19 12:20:39,057 DEBUG : BROWSER_OUTPUT: RSS: Main: 248283136 12:20:39 INFO - 2015-11-19 12:20:39,057 DEBUG : BROWSER_OUTPUT: 12:20:41 INFO - 2015-11-19 12:20:41,726 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-dft) 12:20:42 INFO - 2015-11-19 12:20:42,330 DEBUG : BROWSER_OUTPUT: RSS: Main: 258482176 12:20:42 INFO - 2015-11-19 12:20:42,330 DEBUG : BROWSER_OUTPUT: 12:20:45 INFO - 2015-11-19 12:20:45,507 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-fft) 12:20:46 INFO - 2015-11-19 12:20:46,090 DEBUG : BROWSER_OUTPUT: RSS: Main: 261918720 12:20:46 INFO - 2015-11-19 12:20:46,090 DEBUG : BROWSER_OUTPUT: 12:20:48 INFO - 2015-11-19 12:20:48,036 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator) 12:20:48 INFO - 2015-11-19 12:20:48,663 DEBUG : BROWSER_OUTPUT: RSS: Main: 263057408 12:20:48 INFO - 2015-11-19 12:20:48,664 DEBUG : BROWSER_OUTPUT: 12:20:50 INFO - 2015-11-19 12:20:50,713 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur) 12:20:51 INFO - 2015-11-19 12:20:51,297 DEBUG : BROWSER_OUTPUT: RSS: Main: 263729152 12:20:51 INFO - 2015-11-19 12:20:51,297 DEBUG : BROWSER_OUTPUT: 12:20:53 INFO - 2015-11-19 12:20:53,969 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom) 12:20:54 INFO - 2015-11-19 12:20:54,577 DEBUG : BROWSER_OUTPUT: RSS: Main: 263761920 12:20:54 INFO - 2015-11-19 12:20:54,577 DEBUG : BROWSER_OUTPUT: 12:20:57 INFO - 2015-11-19 12:20:57,573 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate) 12:20:58 INFO - 2015-11-19 12:20:58,174 DEBUG : BROWSER_OUTPUT: RSS: Main: 262787072 12:20:58 INFO - 2015-11-19 12:20:58,174 DEBUG : BROWSER_OUTPUT: 12:21:01 INFO - 2015-11-19 12:21:01,024 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial) 12:21:01 INFO - 2015-11-19 12:21:01,624 DEBUG : BROWSER_OUTPUT: RSS: Main: 263274496 12:21:01 INFO - 2015-11-19 12:21:01,624 DEBUG : BROWSER_OUTPUT: 12:21:03 INFO - 2015-11-19 12:21:03,124 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox) 12:21:03 INFO - 2015-11-19 12:21:03,710 DEBUG : BROWSER_OUTPUT: RSS: Main: 263274496 12:21:03 INFO - 2015-11-19 12:21:03,710 DEBUG : BROWSER_OUTPUT: 12:21:05 INFO - 2015-11-19 12:21:05,474 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes) 12:21:06 INFO - 2015-11-19 12:21:06,118 DEBUG : BROWSER_OUTPUT: RSS: Main: 264728576 12:21:06 INFO - 2015-11-19 12:21:06,118 DEBUG : BROWSER_OUTPUT: 12:21:08 INFO - 2015-11-19 12:21:08,307 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm) 12:21:08 INFO - 2015-11-19 12:21:08,915 DEBUG : BROWSER_OUTPUT: RSS: Main: 264736768 12:21:08 INFO - 2015-11-19 12:21:08,915 DEBUG : BROWSER_OUTPUT: 12:21:11 INFO - 2015-11-19 12:21:11,457 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 12:21:12 INFO - 2015-11-19 12:21:12,067 DEBUG : BROWSER_OUTPUT: RSS: Main: 264339456 12:21:12 INFO - 2015-11-19 12:21:12,067 DEBUG : BROWSER_OUTPUT: 12:21:14 INFO - 2015-11-19 12:21:14,668 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 12:21:15 INFO - 2015-11-19 12:21:15,275 DEBUG : BROWSER_OUTPUT: RSS: Main: 264822784 12:21:15 INFO - 2015-11-19 12:21:15,276 DEBUG : BROWSER_OUTPUT: 12:21:16 INFO - 2015-11-19 12:21:16,897 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49269/tests/kraken/driver.html?testName=ai-astar) 12:21:17 INFO - 2015-11-19 12:21:17,151 DEBUG : BROWSER_OUTPUT: RSS: Main: 264265728 12:21:17 INFO - 2015-11-19 12:21:17,151 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-19 12:21:17,151 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:21:17 INFO - 2015-11-19 12:21:17,151 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:21:17 INFO - 2015-11-19 12:21:17,151 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:21:17 INFO - 2015-11-19 12:21:17,151 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:21:17 INFO - 2015-11-19 12:21:17,151 DEBUG : BROWSER_OUTPUT: |0;ai-astar;114;105;123;114;113;125;116;113;114;115 12:21:17 INFO - 2015-11-19 12:21:17,151 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;144;111;169;187;149;143;142;120;185;148 12:21:17 INFO - 2015-11-19 12:21:17,152 DEBUG : BROWSER_OUTPUT: |2;audio-dft;195;189;195;192;187;209;214;194;200;194 12:21:17 INFO - 2015-11-19 12:21:17,152 DEBUG : BROWSER_OUTPUT: |3;audio-fft;67;61;60;86;85;85;115;55;58;59 12:21:17 INFO - 2015-11-19 12:21:17,152 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;76;75;103;75;77;80;130;111;112;115 12:21:17 INFO - 2015-11-19 12:21:17,152 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;94;90;89;89;89;90;90;88;90;91 12:21:17 INFO - 2015-11-19 12:21:17,152 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;135;139;96;97;97;98;150;151;97;97 12:21:17 INFO - 2015-11-19 12:21:17,152 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;91;91;91;90;98;129;92;77;145;144 12:21:17 INFO - 2015-11-19 12:21:17,152 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;59;57;60;58;58;59;58;68;57;57 12:21:17 INFO - 2015-11-19 12:21:17,152 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;67;68;67;66;64;68;70;71;70;77 12:21:17 INFO - 2015-11-19 12:21:17,152 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;86;83;92;107;107;75;105;72;103;106 12:21:17 INFO - 2015-11-19 12:21:17,152 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;121;124;116;124;129;117;130;127;146;128 12:21:17 INFO - 2015-11-19 12:21:17,152 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;150;122;170;173;128;162;174;174;142;139 12:21:17 INFO - 2015-11-19 12:21:17,152 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;67;67;67;66;66;68;67;66;67;66 12:21:17 INFO - 2015-11-19 12:21:17,152 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:21:17 INFO - 2015-11-19 12:21:17,152 DEBUG : BROWSER_OUTPUT: __start_cc_report 12:21:17 INFO - 2015-11-19 12:21:17,153 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,828 12:21:17 INFO - 2015-11-19 12:21:17,153 DEBUG : BROWSER_OUTPUT: __end_cc_report 12:21:17 INFO - 2015-11-19 12:21:17,153 DEBUG : BROWSER_OUTPUT: __startTimestamp1447964477149__endTimestamp 12:21:17 INFO - 2015-11-19 12:21:17,153 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-19 12:21:17,155 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:21:17 INFO - 2015-11-19 12:21:17,155 DEBUG : BROWSER_OUTPUT: Number of tests: 14 12:21:17 INFO - 2015-11-19 12:21:17,155 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-19 12:21:17,155 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:115.20 Median:114.50 stddev:5.53 (4.8%) stddev-sans-first:5.85 12:21:17 INFO - 2015-11-19 12:21:17,155 DEBUG : BROWSER_OUTPUT: Values: 114.0 105.0 123.0 114.0 113.0 125.0 116.0 113.0 114.0 115.0 12:21:17 INFO - 2015-11-19 12:21:17,155 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-19 12:21:17,155 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:149.80 Median:148.50 stddev:24.79 (16.7%) stddev-sans-first:26.20 12:21:17 INFO - 2015-11-19 12:21:17,155 DEBUG : BROWSER_OUTPUT: Values: 144.0 111.0 169.0 187.0 149.0 143.0 142.0 120.0 185.0 148.0 12:21:17 INFO - 2015-11-19 12:21:17,155 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-19 12:21:17,155 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:196.90 Median:195.00 stddev:8.54 (4.4%) stddev-sans-first:9.03 12:21:17 INFO - 2015-11-19 12:21:17,155 DEBUG : BROWSER_OUTPUT: Values: 195.0 189.0 195.0 192.0 187.0 209.0 214.0 194.0 200.0 194.0 12:21:17 INFO - 2015-11-19 12:21:17,155 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-19 12:21:17,156 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:73.10 Median:64.00 stddev:19.19 (30.0%) stddev-sans-first:20.23 12:21:17 INFO - 2015-11-19 12:21:17,156 DEBUG : BROWSER_OUTPUT: Values: 67.0 61.0 60.0 86.0 85.0 85.0 115.0 55.0 58.0 59.0 12:21:17 INFO - 2015-11-19 12:21:17,156 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-19 12:21:17,156 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:95.40 Median:75.00 stddev:20.93 (27.9%) stddev-sans-first:20.99 12:21:17 INFO - 2015-11-19 12:21:17,156 DEBUG : BROWSER_OUTPUT: Values: 76.0 75.0 103.0 75.0 77.0 80.0 130.0 111.0 112.0 115.0 12:21:17 INFO - 2015-11-19 12:21:17,156 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-19 12:21:17,156 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:90.00 stddev:1.63 (1.8%) stddev-sans-first:0.88 12:21:17 INFO - 2015-11-19 12:21:17,156 DEBUG : BROWSER_OUTPUT: Values: 94.0 90.0 89.0 89.0 89.0 90.0 90.0 88.0 90.0 91.0 12:21:17 INFO - 2015-11-19 12:21:17,157 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-19 12:21:17,157 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:115.70 Median:97.00 stddev:24.58 (25.3%) stddev-sans-first:25.06 12:21:17 INFO - 2015-11-19 12:21:17,157 DEBUG : BROWSER_OUTPUT: Values: 135.0 139.0 96.0 97.0 97.0 98.0 150.0 151.0 97.0 97.0 12:21:17 INFO - 2015-11-19 12:21:17,157 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-19 12:21:17,157 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:104.80 Median:91.00 stddev:24.75 (27.2%) stddev-sans-first:25.74 12:21:17 INFO - 2015-11-19 12:21:17,157 DEBUG : BROWSER_OUTPUT: Values: 91.0 91.0 91.0 90.0 98.0 129.0 92.0 77.0 145.0 144.0 12:21:17 INFO - 2015-11-19 12:21:17,157 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-19 12:21:17,157 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:59.10 Median:58.50 stddev:3.28 (5.6%) stddev-sans-first:3.48 12:21:17 INFO - 2015-11-19 12:21:17,157 DEBUG : BROWSER_OUTPUT: Values: 59.0 57.0 60.0 58.0 58.0 59.0 58.0 68.0 57.0 57.0 12:21:17 INFO - 2015-11-19 12:21:17,157 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-19 12:21:17,157 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:68.80 Median:69.00 stddev:3.55 (5.1%) stddev-sans-first:3.71 12:21:17 INFO - 2015-11-19 12:21:17,157 DEBUG : BROWSER_OUTPUT: Values: 67.0 68.0 67.0 66.0 64.0 68.0 70.0 71.0 70.0 77.0 12:21:17 INFO - 2015-11-19 12:21:17,158 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-19 12:21:17,158 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:93.60 Median:73.50 stddev:13.81 (18.8%) stddev-sans-first:14.37 12:21:17 INFO - 2015-11-19 12:21:17,158 DEBUG : BROWSER_OUTPUT: Values: 86.0 83.0 92.0 107.0 107.0 75.0 105.0 72.0 103.0 106.0 12:21:17 INFO - 2015-11-19 12:21:17,158 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-19 12:21:17,158 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:126.20 Median:127.50 stddev:8.46 (6.6%) stddev-sans-first:8.76 12:21:17 INFO - 2015-11-19 12:21:17,158 DEBUG : BROWSER_OUTPUT: Values: 121.0 124.0 116.0 124.0 129.0 117.0 130.0 127.0 146.0 128.0 12:21:17 INFO - 2015-11-19 12:21:17,158 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-19 12:21:17,159 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:153.40 Median:166.00 stddev:19.90 (12.0%) stddev-sans-first:21.06 12:21:17 INFO - 2015-11-19 12:21:17,159 DEBUG : BROWSER_OUTPUT: Values: 150.0 122.0 170.0 173.0 128.0 162.0 174.0 174.0 142.0 139.0 12:21:17 INFO - 2015-11-19 12:21:17,159 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-19 12:21:17,160 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.70 Median:67.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 12:21:17 INFO - 2015-11-19 12:21:17,160 DEBUG : BROWSER_OUTPUT: Values: 67.0 67.0 67.0 66.0 66.0 68.0 67.0 66.0 67.0 66.0 12:21:17 INFO - 2015-11-19 12:21:17,160 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:21:17 INFO - 2015-11-19 12:21:17,160 DEBUG : BROWSER_OUTPUT: 12:21:17 INFO - 2015-11-19 12:21:17,890 INFO : Browser exited with error code: 0 12:21:17 INFO - 2015-11-19 12:21:17,935 INFO : Completed test kraken (00:00:57) 12:21:17 INFO - 2015-11-19 12:21:17,935 INFO : Starting test v8_7 12:21:17 INFO - 2015-11-19 12:21:17,935 DEBUG : operating with platform_type : mac_ 12:21:17 INFO - 2015-11-19 12:21:17,936 INFO : Initialising browser for v8_7 test... 12:21:17 INFO - 2015-11-19 12:21:17,947 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpiOh82q/profile http://localhost:49269/getInfo.html 12:21:20 INFO - 2015-11-19 12:21:20,455 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 12:21:20 INFO - 2015-11-19 12:21:20,456 DEBUG : BROWSER_OUTPUT: colorDepth:24 12:21:20 INFO - 2015-11-19 12:21:20,456 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/689 12:21:20 INFO - 2015-11-19 12:21:20,456 DEBUG : BROWSER_OUTPUT: __metrics 12:21:21 INFO - 2015-11-19 12:21:21,074 INFO : Browser initialized. 12:21:21 INFO - 2015-11-19 12:21:21,074 INFO : Running cycle 1/1 for v8_7 test... 12:21:21 INFO - 2015-11-19 12:21:21,074 DEBUG : command line: /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/tmpiOh82q/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 12:21:33 INFO - 2015-11-19 12:21:33,072 DEBUG : BROWSER_OUTPUT: RSS: Main: 237289472 12:21:33 INFO - 2015-11-19 12:21:33,072 DEBUG : BROWSER_OUTPUT: 12:21:54 INFO - 2015-11-19 12:21:54,512 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49269/tests/v8_7/run.html (next: http://localhost:49269/tests/v8_7/run.html) 12:21:54 INFO - 2015-11-19 12:21:54,761 DEBUG : BROWSER_OUTPUT: RSS: Main: 246554624 12:21:54 INFO - 2015-11-19 12:21:54,761 DEBUG : BROWSER_OUTPUT: 12:21:54 INFO - 2015-11-19 12:21:54,761 DEBUG : BROWSER_OUTPUT: __start_tp_report 12:21:54 INFO - 2015-11-19 12:21:54,761 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 12:21:54 INFO - 2015-11-19 12:21:54,761 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 12:21:54 INFO - 2015-11-19 12:21:54,761 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 12:21:54 INFO - 2015-11-19 12:21:54,761 DEBUG : BROWSER_OUTPUT: |0;Richards;146.177459435755 12:21:54 INFO - 2015-11-19 12:21:54,761 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;157.5547502757208 12:21:54 INFO - 2015-11-19 12:21:54,762 DEBUG : BROWSER_OUTPUT: |2;Encrypt;285.143997718848 12:21:54 INFO - 2015-11-19 12:21:54,762 DEBUG : BROWSER_OUTPUT: |3;Decrypt;4940.8866995073895 12:21:54 INFO - 2015-11-19 12:21:54,762 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1095.290251916758 12:21:54 INFO - 2015-11-19 12:21:54,762 DEBUG : BROWSER_OUTPUT: |5;Earley;733.1378299120234 12:21:54 INFO - 2015-11-19 12:21:54,762 DEBUG : BROWSER_OUTPUT: |6;Boyer;12580.246913580248 12:21:54 INFO - 2015-11-19 12:21:54,762 DEBUG : BROWSER_OUTPUT: |7;RegExp;26447.36842105263 12:21:54 INFO - 2015-11-19 12:21:54,762 DEBUG : BROWSER_OUTPUT: |8;Splay;798.7220447284345 12:21:54 INFO - 2015-11-19 12:21:54,762 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;4550 12:21:54 INFO - 2015-11-19 12:21:54,762 DEBUG : BROWSER_OUTPUT: __end_tp_report 12:21:54 INFO - 2015-11-19 12:21:54,762 DEBUG : BROWSER_OUTPUT: __startTimestamp1447964514759__endTimestamp 12:21:54 INFO - 2015-11-19 12:21:54,762 DEBUG : BROWSER_OUTPUT: 12:21:54 INFO - 2015-11-19 12:21:54,762 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 12:21:54 INFO - 2015-11-19 12:21:54,762 DEBUG : BROWSER_OUTPUT: Number of tests: 10 12:21:54 INFO - 2015-11-19 12:21:54,762 DEBUG : BROWSER_OUTPUT: 12:21:54 INFO - 2015-11-19 12:21:54,763 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:146.18 Median:146.18 stddev:0.00 (0.0%) 12:21:54 INFO - 2015-11-19 12:21:54,763 DEBUG : BROWSER_OUTPUT: Values: 146.2 12:21:54 INFO - 2015-11-19 12:21:54,763 DEBUG : BROWSER_OUTPUT: 12:21:54 INFO - 2015-11-19 12:21:54,763 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:157.55 Median:157.55 stddev:0.00 (0.0%) 12:21:54 INFO - 2015-11-19 12:21:54,763 DEBUG : BROWSER_OUTPUT: Values: 157.6 12:21:54 INFO - 2015-11-19 12:21:54,763 DEBUG : BROWSER_OUTPUT: 12:21:54 INFO - 2015-11-19 12:21:54,763 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:285.14 Median:285.14 stddev:0.00 (0.0%) 12:21:54 INFO - 2015-11-19 12:21:54,763 DEBUG : BROWSER_OUTPUT: Values: 285.1 12:21:54 INFO - 2015-11-19 12:21:54,763 DEBUG : BROWSER_OUTPUT: 12:21:54 INFO - 2015-11-19 12:21:54,763 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:4940.89 Median:4940.89 stddev:0.00 (0.0%) 12:21:54 INFO - 2015-11-19 12:21:54,763 DEBUG : BROWSER_OUTPUT: Values: 4940.9 12:21:54 INFO - 2015-11-19 12:21:54,763 DEBUG : BROWSER_OUTPUT: 12:21:54 INFO - 2015-11-19 12:21:54,763 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1095.29 Median:1095.29 stddev:0.00 (0.0%) 12:21:54 INFO - 2015-11-19 12:21:54,764 DEBUG : BROWSER_OUTPUT: Values: 1095.3 12:21:54 INFO - 2015-11-19 12:21:54,764 DEBUG : BROWSER_OUTPUT: 12:21:54 INFO - 2015-11-19 12:21:54,764 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:733.14 Median:733.14 stddev:0.00 (0.0%) 12:21:54 INFO - 2015-11-19 12:21:54,764 DEBUG : BROWSER_OUTPUT: Values: 733.1 12:21:54 INFO - 2015-11-19 12:21:54,764 DEBUG : BROWSER_OUTPUT: 12:21:54 INFO - 2015-11-19 12:21:54,764 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:12580.25 Median:12580.25 stddev:0.00 (0.0%) 12:21:54 INFO - 2015-11-19 12:21:54,764 DEBUG : BROWSER_OUTPUT: Values: 12580.2 12:21:54 INFO - 2015-11-19 12:21:54,764 DEBUG : BROWSER_OUTPUT: 12:21:54 INFO - 2015-11-19 12:21:54,764 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:26447.37 Median:26447.37 stddev:0.00 (0.0%) 12:21:54 INFO - 2015-11-19 12:21:54,764 DEBUG : BROWSER_OUTPUT: Values: 26447.4 12:21:54 INFO - 2015-11-19 12:21:54,764 DEBUG : BROWSER_OUTPUT: 12:21:54 INFO - 2015-11-19 12:21:54,764 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:798.72 Median:798.72 stddev:0.00 (0.0%) 12:21:54 INFO - 2015-11-19 12:21:54,764 DEBUG : BROWSER_OUTPUT: Values: 798.7 12:21:54 INFO - 2015-11-19 12:21:54,764 DEBUG : BROWSER_OUTPUT: 12:21:54 INFO - 2015-11-19 12:21:54,764 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:4550.00 Median:4550.00 stddev:0.00 (0.0%) 12:21:54 INFO - 2015-11-19 12:21:54,765 DEBUG : BROWSER_OUTPUT: Values: 4550.0 12:21:54 INFO - 2015-11-19 12:21:54,765 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 12:21:54 INFO - 2015-11-19 12:21:54,765 DEBUG : BROWSER_OUTPUT: 12:21:55 INFO - 2015-11-19 12:21:55,353 INFO : Browser exited with error code: 0 12:21:55 INFO - 2015-11-19 12:21:55,370 INFO : Completed test v8_7 (00:00:37) 12:21:55 INFO - 2015-11-19 12:21:55,831 INFO : Completed test suite (00:20:05) 12:21:55 INFO - 2015-11-19 12:21:55,831 DEBUG : Working with test: dromaeo_css 12:21:55 INFO - 2015-11-19 12:21:55,831 DEBUG : Generating results file: dromaeo_css 12:21:55 INFO - 2015-11-19 12:21:55,832 DEBUG : Working with test: kraken 12:21:55 INFO - 2015-11-19 12:21:55,832 DEBUG : Generating results file: kraken 12:21:55 INFO - 2015-11-19 12:21:55,832 INFO : javascript benchmark 12:21:55 INFO - 2015-11-19 12:21:55,832 DEBUG : Working with test: v8_7 12:21:55 INFO - 2015-11-19 12:21:55,832 DEBUG : Generating results file: v8_7 12:21:55 INFO - 2015-11-19 12:21:55,833 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:21:56 INFO - 2015-11-19 12:21:56,220 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,64,61]] 12:21:56 INFO - 2015-11-19 12:21:56,221 DEBUG : process_Request line: dromaeo_css 7275.31 graph.html#tests=[[72,64,61]] 12:21:56 INFO - 2015-11-19 12:21:56,221 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:21:56 INFO - 2015-11-19 12:21:56,246 DEBUG : process_Request line: kraken 1508.70 graph.html#tests=[[232,64,61]] 12:21:56 INFO - 2015-11-19 12:21:56,246 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 12:21:56 INFO - 2015-11-19 12:21:56,278 DEBUG : process_Request line: v8_7 21365.68 graph.html#tests=[[230,64,61]] 12:21:56 INFO - 2015-11-19 12:21:56,279 INFO : javascript benchmark 12:21:56 INFO - 2015-11-19 12:21:56,281 INFO : PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [3135.9372812543747, 3547.0954906498823, 3595.1371670799, 3603.72972027098, 3611.620779818119, 5572.498475137242, 5848.0, 6001.459868611819, 6044.486218671407, 6065.211522502074, 5963.701814909259, 5976.342602313753, 5994.8801023979495, 6081.726322315495, 6099.612447337997, 4510.909781804362, 5366.570674346062, 5458.890822183554, 5495.395506494302, 5533.474319939599, 4903.0, 5505.421930697279, 5565.443455654422, 5583.4974852263285, 5614.606977511576, 5229.790808367642, 5310.973445132789, 5367.865803354908, 5429.267048948421, 5462.617616766828, 5283.07546179417, 5288.444713305124, 5289.603279754034, 5324.041672498949, 5467.617266791326, 5285.762140703678, 5287.709175995319, 5301.416844147141, 5322.813701520428, 5331.333583302087, 5514.117741161435, 5872.354041055481, 5929.75475150219, 5964.105384192362, 6041.848953776147, 6377.0, 6386.201724784402, 6395.904061439082, 6423.940049891762, 6447.194100737408, 5393.379761327419, 6370.171877655921, 6497.93502064978, 6536.379043990813, 6538.803835884931, 6111.724972376253, 6131.294901086388, 6193.535484838655, 6207.472364848948, 6221.2845522765465, 6571.934280657228, 6653.866922661519, 6661.2006559213205, 6681.064650948871, 6697.296783837627, 6180.845478862974, 6282.591631543935, 6297.52768542352, 6357.0, 6358.936410635927, 6378.0, 6417.679116044273, 6451.806445806634, 6481.773137940149, 6508.316626754123, 5594.776208951596, 5997.740474500404, 6338.859005378984, 6386.744530218833, 6388.4569811566535, 6183.227096612924, 6246.812595622138, 6319.873602527924, 6328.46208072319, 6377.5216858735785, 5150.896982060338, 5158.3552055993005, 5161.27742116104, 5161.896762064813, 5167.044096842096, 4625.8843528911375, 4629.583337499641, 4654.720716756938, 4655.255159174583, 4714.080754252887, 5964.850878728066, 6081.452669259788, 6103.84740381494, 6155.938440615626, 6234.875302494015, 6384.361563843579, 6397.0, 6418.069379939882, 6432.356764323624, 6442.259140198843, 6179.011358182669, 6192.690365481708, 6206.782762603287, 6209.6895155242055, 6212.875742485125, 5463.7814487420055, 5560.555155587544, 5567.164925261243, 5626.437356264422, 5689.374168841424, 6549.443297319781, 6586.670666466657, 6631.535792494479, 6641.501887358564, 6652.002199670088, 6240.871198195646, 6447.871042579216, 6449.161608990801, 6462.5153113515735, 6463.450606698483, 6501.2523559791225, 6502.869942601216, 6540.672966351759, 6556.114924485133, 6583.44040756541, 5311.601629877852, 6352.650604216812, 6364.872702546016, 6367.649779262185, 6384.553081284265, 6258.092576576462, 6326.905096423466, 6442.645654489048, 6469.708863101077, 6472.093906853139, 5055.848324550269, 6092.268927728701, 6140.872371569611, 6271.498280137487, 6286.465650419766, 6306.61254524004, 6309.779157729457, 6314.273858506331, 6330.398612132024, 6341.207349081365, 6034.034554471264, 6127.372786728296, 6146.815595532141, 6247.437730604267, 6302.873942521215, 5092.828649410582, 6338.936610633835, 6341.175647165839, 6341.207349081365, 6355.586886852339, 6210.627362358273, 6251.156093927443, 6259.906101408392, 6306.842328941813, 6309.558330916975], "unit": "ms", "name": "dojo.html", "value": 5889.9338453199425}, {"lowerIsBetter": false, "replicates": [566.9177969194467, 567.9176519404689, 573.7543428014013, 608.5922431970579, 613.3866133866137, 32544.0, 40268.1946361073, 40733.0, 40775.796121019426, 40848.79575602118, 44618.55381446185, 44866.878328041814, 44965.55034449654, 45246.09507809842, 45328.546714532844, 9977.40135591865, 10082.395056296646, 10178.643747468841, 10200.693979180636, 10201.132903703194, 9953.0, 10043.19654427644, 10060.295779295453, 10063.647772327933, 10071.848922266172, 9975.75060623483, 10043.447610381427, 10096.09135177834, 10098.444585547792, 10115.949420252888, 9964.800703985917, 10042.096211340979, 10054.09513143817, 10065.69802905914, 10078.344907580984, 9802.0, 9959.0, 9962.800743985152, 9965.601375945025, 10021.849672254923, 42666.360004599956, 42790.0, 42998.57001429977, 43206.35190472146, 43270.35094473585, 3245.5618491503583, 3263.863727733422, 3304.9173770655684, 3497.3704733148024, 3613.385724426854, 28878.71121288802, 29857.552136717968, 30011.699883001107, 30307.0, 30349.24126896823, 2600.8569528675916, 2620.2008387441824, 2622.7246139155304, 2638.28766233116, 2660.361513236809, 423678.0, 484014.99999999645, 494669.0, 494722.0, 495288.0, 56861.0, 57910.71044644834, 70824.64587677132, 71156.0, 71663.6416817923, 71832.0, 71863.0, 72022.0, 72267.0, 72494.63752681308, 16583.17084145788, 16961.91519042397, 16964.0, 17079.658406831793, 17140.0, 12656.43046062911, 12838.67903302425, 12884.484620615258, 12906.612801615967, 13035.348232588332, 18793.530161746065, 21208.469788255417, 21646.567068658853, 21890.90545472752, 21958.560828783335, 7652.0, 7755.914172015922, 8638.56807159652, 8889.73330800077, 9042.819143617091, 724.5145752345941, 898.8786513820551, 965.4545181972304, 1069.2996087562658, 1077.7144056824948, 29722.851385743365, 29758.85120574383, 29915.850420748193, 30439.543406848916, 30513.69486305153, 1046.2414749306693, 1114.0753174864842, 1116.2576886370473, 1181.1554738362113, 1187.0681515010674, 15271.847281527043, 15476.613084672974, 15625.374985000473, 15761.0, 15897.364105435885, 524896.0, 557761.0, 558311.0, 563358.0, 564439.0, 45400.54599454029, 60299.39700603025, 60490.18529444124, 60680.69659651673, 61112.38887611067, 1390.5897760160776, 1405.2552147361914, 1407.6973450708147, 1424.9287535623178, 1441.128117488925, 28487.43025139527, 29735.0, 29758.25604359908, 30297.848510758187, 30425.0, 53658.463415365346, 53796.46203538071, 53821.19268211058, 53882.922341553734, 54195.729021354644, 499160.0, 499295.0, 501400.0, 502560.0, 505773.0, 34005.809796657, 34906.65093349136, 34965.0, 35017.94946151518, 35019.64980350266, 43787.562124378346, 44331.0, 45573.0, 45944.7702761484, 45962.540374595825, 38742.61257387503, 38969.0, 39012.219755604165, 39130.80434597809, 39266.60733392744, 37764.35649504618, 38149.0, 38878.41682374823, 38981.0, 38993.8050309758, 37034.629653703116, 37662.623373767005, 38242.426363605126, 38383.80808095942, 38399.616003839605, 28749.856250718614, 31399.529007064455, 33542.99371018873, 34008.3198336027, 34480.96557103291, 24902.75097249077, 25208.495830082928, 25366.873165634053, 25573.104941326965, 25674.871625641754], "unit": "ms", "name": "ext.html", "value": 20405.582826866947}, {"lowerIsBetter": false, "replicates": [352.68258567289445, 353.688753896571, 353.720560757002, 353.9964600353996, 356.87687747727034, 16111.758323625156, 17892.194851231692, 19768.60462790745, 20068.197272109097, 20679.689804652942, 12323.198992065532, 12529.68675783106, 12611.18027328223, 12616.432260548274, 19940.70088948667, 4226.0, 4552.995023284625, 4795.736234507101, 4799.976000119995, 4809.639277054235, 4769.737664428455, 4974.427940786802, 5064.848054558351, 5101.846944591668, 5113.181890897457, 4926.802927882881, 4989.326440930482, 5044.520770526794, 5054.797808087672, 5133.358330208724, 5090.77091530882, 5099.311592934943, 5103.872403189913, 5121.283020377132, 5129.769160387754, 4304.268274393329, 4306.633936115434, 4329.740215587043, 4337.0458499130145, 4344.283193273138, 13532.052756307063, 13550.525731599346, 13902.860971390257, 13970.371333289924, 14058.648533786634, 1919.5201199700075, 1922.1062206074243, 1930.903454827267, 2011.1352118589, 2015.3752336775647, 9791.706248812547, 9880.0, 9924.31286681266, 10089.243306752023, 10197.89802101977, 1428.3429622373721, 1592.920353982308, 1612.11333766428, 1629.8370162983726, 1668.7413450915128, 93315.53342233246, 97291.54062688994, 98079.0192098077, 98830.99999999929, 99377.0, 6847.589144651337, 6855.108835851307, 6882.5870447773295, 6904.758333458305, 6953.652317384111, 7707.267809558083, 7729.304362607392, 7734.5359278443475, 7762.184970578121, 7806.0, 5746.080627099644, 5764.74058667361, 5777.6822274775295, 5789.565782566325, 5789.797357092481, 6234.470070044006, 6253.96873015632, 6259.061140828912, 6271.216097987752, 6297.559170858088, 2519.4961007798515, 2989.671136175019, 3019.686436400173, 3022.1386904732044, 3056.3581647853757, 1080.702806728156, 1084.3656460970262, 1085.0722632149557, 1132.365875109941, 1135.0465608888574, 424.35921758145423, 425.2600475173238, 436.5808823529384, 466.02368038958326, 469.610223514489, 11285.492152853141, 12584.37078146089, 12585.87414125847, 12718.236905785683, 12760.106792524433, 464.1969392950215, 470.2335193634354, 473.7844280852204, 486.67392846792023, 504.48794473609314, 6598.637074960827, 6621.536492445579, 6649.102371179829, 6696.0960270362875, 6728.730850766013, 677098.6145069243, 704554.0, 738625.0, 761690.0, 772140.0, 93211.07705844943, 119461.0, 119629.0, 120037.0, 123669.0, 515.4561937156336, 521.2259794205677, 522.088954773922, 542.7232111623022, 543.9728013599304, 11595.884041159481, 11817.0, 11941.22382045199, 11976.28142311464, 12027.0, 46874.53125468702, 48007.519924800305, 49161.754191228814, 51188.0, 51335.0, 49411.50588494069, 52504.42486725404, 53701.731491342296, 67297.32702672911, 68098.0, 6331.525135614939, 6489.0, 6551.148350714377, 6560.639164845788, 6573.3098024706715, 11600.723920368922, 11867.109966752356, 12645.304508252135, 12718.236905785312, 12795.168314059556, 10222.13111885498, 10374.910634383583, 10907.945460272966, 11189.944050279697, 11313.71715707114, 10880.455977201267, 10906.236563440483, 10916.672499825017, 11028.338299702044, 11063.668089957315, 10263.7434064149, 10611.363318200933, 11430.0, 11451.828222576502, 11492.367919764492, 5626.381098079126, 6396.968015159894, 6479.416852483299, 6480.902786458301, 6536.379043990813, 10945.562177512811, 10977.341359518454, 11231.38227397501, 11237.943810280896, 11297.7740445189], "unit": "ms", "name": "jquery.html", "value": 7307.134581027679}, {"lowerIsBetter": false, "replicates": [1394.62345166805, 1446.1756798624783, 1633.5344426838353, 1907.6947688369864, 1929.1415320182525, 7712.961435192816, 7838.372930165588, 7875.779254215591, 8136.593170341482, 8244.134365891578, 8180.954761309673, 8317.209865062809, 8395.832083358344, 8408.327333813295, 8451.070382257947, 2337.2988103568946, 2358.1157066100213, 2372.822038347122, 2376.5009348036933, 2377.3699969508093, 2334.7665233476687, 2345.2260753951155, 2387.6657267982496, 2399.8680072596, 2401.339631601315, 2341.8477798943013, 2364.172539611131, 2393.6768536247646, 2404.903803847853, 2414.5533076380925, 2300.183434880627, 2314.2941402872116, 2324.93025209244, 2329.6272596384665, 2337.567550003238, 2378.8334816562847, 2411.855288682667, 2425.1754403502896, 2428.647846062311, 2434.330559096245, 7505.924940750577, 8237.052738935039, 8289.917100828974, 8327.20891515305, 8392.916070839274, 4696.553827386427, 5135.537801597874, 5222.060029194743, 5232.633715639907, 5251.343582052244, 3221.4362486564755, 3428.971308607408, 3438.1060924159647, 3478.3738926993133, 3502.5271588335504, 1042.7914417116608, 1060.5598676549223, 1067.9199060070525, 1089.5042755546208, 1089.9509522071526, 10645.148388129008, 10728.0, 10755.462226888703, 10766.40784756838, 10880.891191088067, 4648.604868586141, 4668.439787225555, 4683.110209060268, 4730.574248317668, 4738.2418812990445, 9712.951435242778, 9730.464824434583, 9731.90268097324, 9768.120869121813, 9775.804483910424, 5161.122609156452, 5167.612429067835, 5200.037992971313, 5208.921866172011, 5216.895662086737, 4697.906041879143, 4713.57577817998, 4745.217039188564, 4751.453582838018, 4754.02542478791, 3725.5529336479253, 3758.1356288053903, 3771.26460340231, 3777.3956167013694, 3792.886213413602, 1097.9945100274447, 1246.6696325473756, 1257.792464243408, 1262.5265525427965, 1270.1870802686287, 1243.2229856339789, 1247.25788156047, 1271.7011502296953, 1287.3434548380394, 1298.3702904091508, 7793.636113680083, 7805.609719514002, 7846.17615150401, 8027.438079334391, 8028.076771171273, 1195.5277665322149, 1200.2078628105407, 1202.6331968749616, 1218.2203389830515, 1223.3883058470765, 6004.729787159588, 6058.182145410401, 6079.969600151971, 6133.601315914451, 6141.07883817431, 9510.42937423743, 10018.899811001796, 10117.848232276521, 10155.136813370798, 10177.18582513397, 9435.716928492157, 9725.173360264456, 9893.0, 9903.950480247697, 9941.906390297061, 7801.258880406353, 7804.68781248755, 7842.490238134503, 7910.762677119696, 7957.164497727771, 7378.483506154517, 7472.626368681435, 7495.550266983998, 7814.296713295831, 7820.608969551614, 8830.911690883266, 8947.105289471001, 9012.963509196265, 9031.412958157698, 9060.728178154666, 8695.652173912973, 8882.289416846766, 8923.553822308988, 9194.034626364135, 9276.397034192756, 7303.233160518069, 7328.157261914948, 7377.926220737724, 7398.408127349907, 7409.962950185431, 7982.8802567960365, 8005.719799806979, 8006.519608823489, 8014.238647328494, 8019.6391162398995, 6483.513736469689, 7407.111146662435, 7504.924950750641, 7555.206703296075, 7659.463837531543, 7252.673629686571, 7408.370288525536, 7415.147258065392, 7430.4798664093, 7486.326230639051, 7419.183889772229, 7541.660625271767, 7546.396288297033, 7549.207333230152, 7566.546007239584, 6790.7623233186605, 6837.897431538431, 6851.725930962705, 6853.931460685529, 6866.210385805696, 6842.897356539556, 6902.896456553256, 6914.274001229798, 6966.1988871280455, 6966.686499107451], "unit": "ms", "name": "mootools.html", "value": 4775.725470730133}, {"lowerIsBetter": false, "replicates": [269.34683392772524, 321.3973799126638, 322.58386681181275, 331.966803319668, 334.3196594929319, 6963.199232088311, 6969.477289203311, 7114.822129446767, 7187.245339239376, 7192.460565457585, 6868.244493105767, 6959.408450281732, 7025.964870175642, 7029.332213439728, 7056.0, 5095.286659867622, 5104.05574968632, 5104.84685459435, 5109.923351149736, 5125.333706618135, 4911.950880491185, 5090.007448547534, 5096.592272618182, 5107.055194788976, 5120.871978200556, 5004.899902001957, 5015.7492125393765, 5023.146065168912, 5025.974870125644, 5053.216751403538, 5007.84976450707, 5012.699238045729, 5039.4708555601865, 5043.722595257278, 5050.393952725678, 4161.313383291753, 4229.111886503838, 4239.236937351276, 4239.682023848224, 4243.957560424387, 6663.100481434993, 6670.766523171715, 6675.732970681167, 6691.464682825411, 6704.329567043305, 5879.118132280149, 5948.791792287249, 5949.286085669747, 5959.344472108108, 6015.849603759897, 7196.2443943385715, 7450.552966821954, 7463.253674632493, 7472.813179670552, 7488.887666684949, 4346.6522678185665, 4367.432233809616, 4725.574698277137, 4756.6908150970075, 4759.214729569617, 6828.829279268009, 7873.212678732139, 7970.800729981739, 8001.479903806292, 8013.7195198168365, 4679.227927391942, 4817.421909370828, 4818.060478206786, 4846.0, 4851.975740121276, 4152.418661387348, 4848.933234688363, 4904.362432883774, 4920.114379411669, 4935.703857768545, 5900.852478687982, 5929.288485381781, 5954.434328738763, 5970.820875373745, 5981.431763982502, 6089.634621922699, 6154.5384096192965, 7564.0, 7580.3556697681315, 7589.241075892477, 1636.7053930292661, 1712.8886622369507, 1713.0406972095666, 1715.1424287856073, 1720.32047341302, 1064.0264158295229, 1081.0972837680467, 1082.6156714366443, 1088.983665245022, 1089.6022951622758, 7017.508774385846, 7047.753328633473, 7049.541779784297, 7049.718011279491, 7053.153621565445, 7813.335866451302, 7816.335611472975, 7831.6867325307485, 7833.0, 7846.764597062097, 6810.421114205249, 7007.369336759716, 7079.1858936223, 7080.256573059857, 7081.079459670313, 4045.19096180765, 4130.091379896418, 4151.169766046803, 4151.27352713274, 4153.252414565407, 8056.959715201387, 8244.0, 8251.669933202726, 8272.924519812386, 8283.58582070906, 8192.795180120545, 8210.835783284301, 8214.712485062993, 8215.794605134919, 8259.8348033039, 6635.568688035359, 7920.960395198103, 8281.668733250723, 8303.086660467343, 8310.127436619068, 7928.603569821601, 7934.722284720007, 7937.206279372017, 7941.722039728582, 7965.0, 7532.510386824839, 7748.147703752696, 7836.412269079956, 7845.293923546908, 7857.449978501679, 6293.0, 7742.109657389472, 8022.157673444204, 8248.54632995191, 8350.665973360998, 3972.2849887020616, 4827.348307978518, 4831.396075490564, 4833.879153021203, 4854.68444551103, 7695.92304076952, 7906.853506241678, 7919.208079192034, 7925.0, 7941.483803552751, 7594.772156835304, 7622.504537205064, 7622.58075805836, 7647.120581133018, 7650.961745191461, 7386.482946193715, 7573.848523029619, 7596.0, 7598.506097103671, 7604.581748003913, 6632.270450250372, 6907.13660792401, 7407.1852096268285, 7456.664450099867, 7468.701251949861, 6139.785107521216, 7586.962065189638, 7633.618319083913, 7641.044869391326, 7647.502912310682, 7180.660992638239, 7456.440766942393, 7466.178720340867, 7475.813104672427, 7479.439042071976], "unit": "ms", "name": "prototype.html", "value": 5419.6660849783475}, {"lowerIsBetter": false, "replicates": [656.7504348347627, 710.6517806274924, 728.4099879097931, 772.2200577416809, 790.3321693169273, 11946.880531194685, 12040.51837926484, 12075.0, 12082.33547154906, 12123.33321667308, 14137.646558836033, 14296.0, 15619.765703514457, 15812.683746325067, 15842.366305347772, 683.3337495941468, 748.8127968007998, 947.4836214263244, 952.4095061062151, 954.9522523873778, 734.6436978065634, 931.2456909902967, 931.9720408387759, 944.4239014201331, 945.6737425588161, 938.4556956964944, 949.3876449689981, 952.3190918493276, 957.4351132831628, 967.569431602937, 923.4643906534194, 939.4222553129845, 940.3558562384754, 946.517276189145, 950.3585080070959, 696.314130581377, 697.4699228586311, 701.8420855307565, 705.1960764728213, 706.2196273118182, 14744.336504857307, 14754.409823607042, 14823.555293341216, 14825.70348593022, 14846.554603361916, 9105.0, 9806.215502759762, 10159.288849780518, 10541.525631346607, 10926.562937482491, 9595.712128636153, 9615.711528654152, 9628.277879159092, 9919.206463482904, 9931.20550355977, 3103.4568950433586, 3203.3112880730755, 3206.3106432116974, 3207.711305982473, 3266.8203248821305, 69247.0, 70399.29600703978, 71999.28000719978, 72127.63936180338, 72276.55446891085, 7256.854862902818, 7294.9270507295305, 7298.525595836254, 7308.634568271672, 7345.412367010733, 12722.427490762939, 12745.553905613258, 12765.936170319275, 12783.0, 12813.0, 5941.435563621449, 6565.573237739532, 6628.5691430056895, 6827.590344579341, 6830.112085428863, 4095.996480862208, 4105.938410923838, 4138.8551400700835, 4211.073563815956, 4380.78096095194, 3167.7307428868803, 3188.3782662380613, 3199.6800319967815, 3204.0548038328748, 3205.7916235444623, 485.65518481878263, 503.3833553896521, 506.35186960690373, 519.1667373864892, 521.705236541353, 468.7304799740163, 497.28887690602784, 499.16140883316376, 515.8281165850541, 531.7766538054027, 8598.269147122439, 8679.218870301704, 8683.956580217058, 8806.119388061143, 8883.200511953955, 499.4406264983242, 524.7114087252072, 525.2226704477395, 526.8208809004957, 588.9957622254132, 3393.4909763535666, 4027.959720402817, 4033.3748269018347, 4106.240345536085, 4209.284421648327, 93222.0, 93883.0, 94644.0, 95296.52351738197, 103537.48231258795, 77948.0, 78780.60609696915, 81076.18923810804, 81158.18841811625, 81300.59349703214, 73910.26089739142, 75074.87387689188, 75318.0, 75387.62306188434, 76525.61737191278, 9078.954605227196, 9129.634814607341, 9136.817263654822, 9214.170724634814, 9230.815383692423, 50255.0, 51049.72375690637, 51089.23366149436, 51477.0, 52141.26446090851, 52660.683482913235, 65534.34465655282, 69849.0, 76301.0, 78264.60867695625, 6579.934200657932, 7933.3653307734085, 7965.681372745257, 8072.556009419538, 8178.059523154913, 12166.75666486683, 12486.313252771184, 12552.623421297376, 12662.493500259887, 13099.541516047273, 11668.0, 11746.0, 12183.208091474025, 12224.266544007389, 12458.252504849737, 11391.601293954673, 11633.76732465329, 11857.288562686266, 12046.156769026084, 12520.373981301082, 10363.610182872779, 10437.425941573287, 11414.972652461318, 11517.481713323088, 12431.813522796985, 9130.360874738704, 9297.442153470813, 9449.669261575811, 9491.66779162726, 9665.806683866143, 8731.388802783744, 8787.692430764893, 9144.954275228582, 9163.633454661738, 10032.197424206191], "unit": "ms", "name": "yui.html", "value": 6523.135954150744}], "name": "dromaeo_css", "value": 7275.309295120903}, {"lowerIsBetter": true, "subtests": [{"lowerIsBetter": true, "replicates": [114.0, 105.0, 123.0, 114.0, 113.0, 125.0, 116.0, 113.0, 114.0, 115.0], "unit": "ms", "name": "ai-astar", "value": 115.2}, {"lowerIsBetter": true, "replicates": [144.0, 111.0, 169.0, 187.0, 149.0, 143.0, 142.0, 120.0, 185.0, 148.0], "unit": "ms", "name": "audio-beat-detection", "value": 149.8}, {"lowerIsBetter": true, "replicates": [195.0, 189.0, 195.0, 192.0, 187.0, 209.0, 214.0, 194.0, 200.0, 194.0], "unit": "ms", "name": "audio-dft", "value": 196.9}, {"lowerIsBetter": true, "replicates": [67.0, 61.0, 60.0, 86.0, 85.0, 85.0, 115.0, 55.0, 58.0, 59.0], "unit": "ms", "name": "audio-fft", "value": 73.1}, {"lowerIsBetter": true, "replicates": [76.0, 75.0, 103.0, 75.0, 77.0, 80.0, 130.0, 111.0, 112.0, 115.0], "unit": "ms", "name": "audio-oscillator", "value": 95.4}, {"lowerIsBetter": true, "replicates": [94.0, 90.0, 89.0, 89.0, 89.0, 90.0, 90.0, 88.0, 90.0, 91.0], "unit": "ms", "name": "imaging-gaussian-blur", "value": 90.0}, {"lowerIsBetter": true, "replicates": [135.0, 139.0, 96.0, 97.0, 97.0, 98.0, 150.0, 151.0, 97.0, 97.0], "unit": "ms", "name": "imaging-darkroom", "value": 115.7}, {"lowerIsBetter": true, "replicates": [91.0, 91.0, 91.0, 90.0, 98.0, 129.0, 92.0, 77.0, 145.0, 144.0], "unit": "ms", "name": "imaging-desaturate", "value": 104.8}, {"lowerIsBetter": true, "replicates": [59.0, 57.0, 60.0, 58.0, 58.0, 59.0, 58.0, 68.0, 57.0, 57.0], "unit": "ms", "name": "json-parse-financial", "value": 59.1}, {"lowerIsBetter": true, "replicates": [67.0, 68.0, 67.0, 66.0, 64.0, 68.0, 70.0, 71.0, 70.0, 77.0], "unit": "ms", "name": "json-stringify-tinderbox", "value": 68.8}, {"lowerIsBetter": true, "replicates": [86.0, 83.0, 92.0, 107.0, 107.0, 75.0, 105.0, 72.0, 103.0, 106.0], "unit": "ms", "name": "stanford-crypto-aes", "value": 93.6}, {"lowerIsBetter": true, "replicates": [121.0, 124.0, 116.0, 124.0, 129.0, 117.0, 130.0, 127.0, 146.0, 128.0], "unit": "ms", "name": "stanford-crypto-ccm", "value": 126.2}, {"lowerIsBetter": true, "replicates": [150.0, 122.0, 170.0, 173.0, 128.0, 162.0, 174.0, 174.0, 142.0, 139.0], "unit": "ms", "name": "stanford-crypto-pbkdf2", "value": 153.4}, {"lowerIsBetter": true, "replicates": [67.0, 67.0, 67.0, 66.0, 66.0, 68.0, 67.0, 66.0, 67.0, 66.0], "unit": "ms", "name": "stanford-crypto-sha256-iterative", "value": 66.7}], "name": "kraken", "value": 1508.7}, {"lowerIsBetter": false, "subtests": [{"lowerIsBetter": false, "replicates": [146.177459435755], "unit": "score", "name": "Richards", "value": 241.50098199999996}, {"lowerIsBetter": false, "replicates": [157.5547502757208], "unit": "score", "name": "DeltaBlue", "value": 419.65094599999986}, {"lowerIsBetter": false, "replicates": [285.143997718848], "unit": "score", "name": "Encrypt", "value": 933.4967669999996}, {"lowerIsBetter": false, "replicates": [4940.8866995073895], "unit": "score", "name": "Decrypt", "value": 53.87312362911262}, {"lowerIsBetter": false, "replicates": [1095.290251916758], "unit": "score", "name": "RayTrace", "value": 675.6099569999998}, {"lowerIsBetter": false, "replicates": [733.1378299120234], "unit": "score", "name": "Earley", "value": 909.0555320000003}, {"lowerIsBetter": false, "replicates": [12580.246913580248], "unit": "score", "name": "Boyer", "value": 52.976941118743895}, {"lowerIsBetter": false, "replicates": [26447.36842105263], "unit": "score", "name": "RegExp", "value": 34.44520398009948}, {"lowerIsBetter": false, "replicates": [798.7220447284345], "unit": "score", "name": "Splay", "value": 102.02673199999995}, {"lowerIsBetter": false, "replicates": [4550.0], "unit": "score", "name": "NavierStokes", "value": 326.15384615384613}], "name": "v8_7", "value": 21365.681641309908}]} 12:21:56 INFO - RETURN: dromaeo_css: 7275.31 12:21:56 INFO - RETURN: kraken: 1508.70 12:21:56 INFO - RETURN: v8_7: 21365.68 12:21:56 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,64,61]]", "result": "21365.68"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,64,61]]", "result": "1508.70"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,64,61]]", "result": "7275.31"}}} 12:21:56 INFO - Return code: 0 12:21:56 INFO - # TBPL SUCCESS # 12:21:56 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 12:21:56 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 12:21:56 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 12:21:56 INFO - 2015-11-19 12:21:56.375 screenresolution[1679:10915] starting screenresolution argv=screenresolution get 12:21:56 INFO - 2015-11-19 12:21:56.378 screenresolution[1679:10915] Display 0: 1600x1200x32@60 12:21:56 INFO - 2015-11-19 12:21:56.384 screenresolution[1680:10918] starting screenresolution argv=screenresolution list 12:21:56 INFO - Available Modes on Display 0 12:21:56 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 12:21:56 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 12:21:56 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 12:21:56 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 12:21:56 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 12:21:56 INFO - Intel Iris: 12:21:56 INFO - Chipset Model: Intel Iris 12:21:56 INFO - Type: GPU 12:21:56 INFO - Bus: Built-In 12:21:56 INFO - VRAM (Dynamic, Max): 1536 MB 12:21:56 INFO - Vendor: Intel (0x8086) 12:21:56 INFO - Device ID: 0x0a2e 12:21:56 INFO - Revision ID: 0x0009 12:21:56 INFO - Displays: 12:21:56 INFO - Display: 12:21:56 INFO - Resolution: 1600 x 1200 @ 60 Hz 12:21:56 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 12:21:56 INFO - Display Serial Number: 1600x1200 60 12:21:56 INFO - Main Display: Yes 12:21:56 INFO - Mirror: Off 12:21:56 INFO - Online: Yes 12:21:56 INFO - Rotation: Supported 12:21:56 INFO - Return code: 0 12:21:56 INFO - Running post-action listener: _resource_record_post_action 12:21:56 INFO - Running post-run listener: _resource_record_post_run 12:21:57 INFO - Total resource usage - Wall time: 1237s; CPU: 53.0%; Read bytes: 33574400; Write bytes: 694518272; Read time: 352; Write time: 2331 12:21:57 INFO - install - Wall time: 31s; CPU: 54.0%; Read bytes: 334246400; Write bytes: 335902720; Read time: 26088; Write time: 646 12:21:57 INFO - run-tests - Wall time: 1207s; CPU: 53.0%; Read bytes: 32648704; Write bytes: 347138560; Read time: 339; Write time: 1647 12:21:57 INFO - Running post-run listener: _upload_blobber_files 12:21:57 INFO - Blob upload gear active. 12:21:57 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 12:21:57 INFO - Copying logs to upload dir... 12:21:57 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1284.404396 ========= master_lag: 2.58 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2015-11-19 12:22:00.274700) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 12:22:00.275793) ========= 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.Q9FfmA2y2M/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.2h5rlyCti9/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.009398 build_url: 'https://queue.taskcluster.net/v1/task/eqCAB4HTR46nx7CN1L9HWg/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.26 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-19 12:22:00.547646) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 12:22:00.547953) ========= 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.Q9FfmA2y2M/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.2h5rlyCti9/Listeners TMPDIR=/var/folders/zn/cd1kk5_j395_6yk0j171qxfh00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005055 ========= master_lag: 0.06 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-19 12:22:00.613783) ========= ========= Started reboot skipped (results: 3, elapsed: 5 secs) (at 2015-11-19 12:22:00.614126) ========= ========= Finished reboot skipped (results: 3, elapsed: 5 secs) (at 2015-11-19 12:22:06.329084) ========= ========= Total master_lag: 10.07 =========