builder: mozilla-central_yosemite_test-dromaeojs-e10s slave: t-yosemite-r5-0016 starttime: 1447679213.87 results: success (0) buildid: 20151116030208 builduid: 1535f0fc9132460b9b4ed37dc4583e08 revision: 48d636f678b0e5162ab868dc9024a5ffe350460c ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:53.871492) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:53.872007) ========= ========= Started set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:53.872380) ========= 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.7hzUsvsY7o/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.nba8VR1VON/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False /builds/slave/test program finished with exit code 0 elapsedTime=0.006078 basedir: '/builds/slave/test' ========= master_lag: 0.30 ========= ========= Finished set props: basedir (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:54.178064) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:54.178463) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:54.209393) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:54.209841) ========= 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.7hzUsvsY7o/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.nba8VR1VON/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.013163 ========= master_lag: 0.04 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:54.260234) ========= ========= Started set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:54.260593) ========= script_repo_url: https://hg.mozilla.org/build/mozharness ========= Finished set props: script_repo_url (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:54.261040) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:54.261447) ========= 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.7hzUsvsY7o/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.nba8VR1VON/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False --2015-11-16 05:06:54-- 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-16 05:06:54 (1.41 GB/s) - `archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.240589 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:54.524443) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:54.524810) ========= 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.7hzUsvsY7o/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.nba8VR1VON/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.117587 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:54.658461) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:54.658853) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 48d636f678b0e5162ab868dc9024a5ffe350460c --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev 48d636f678b0e5162ab868dc9024a5ffe350460c --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7hzUsvsY7o/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.nba8VR1VON/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 2015-11-16 05:06:54,749 truncating revision to first 12 chars 2015-11-16 05:06:54,749 Setting DEBUG logging. 2015-11-16 05:06:54,749 attempt 1/10 2015-11-16 05:06:54,749 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/48d636f678b0?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2015-11-16 05:06:55,047 unpacking tar archive at: mozilla-central-48d636f678b0/testing/mozharness/ program finished with exit code 0 elapsedTime=0.606340 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:55.281656) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:55.282044) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:55.296687) ========= ========= Started tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:55.297152) ========= TinderboxPrint: script_revlink: https://hg.mozilla.org/build/mozharness/rev/production ========= Finished tinderboxprint_script_revlink (results: 0, elapsed: 0 secs) (at 2015-11-16 05:06:55.297693) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 55 secs) (at 2015-11-16 05:06:55.298027) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs-e10s', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--system-bits', '64', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.7hzUsvsY7o/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.nba8VR1VON/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False 05:06:55 INFO - MultiFileLogger online at 20151116 05:06:55 in /builds/slave/test 05:06:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Firefox --system-bits 64 --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 05:06:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:06:55 INFO - {'append_to_log': False, 05:06:55 INFO - 'base_work_dir': '/builds/slave/test', 05:06:55 INFO - 'blob_upload_branch': 'Firefox', 05:06:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:06:55 INFO - 'branch': 'Firefox', 05:06:55 INFO - 'buildbot_json_path': 'buildprops.json', 05:06:55 INFO - 'config_files': ('talos/mac_config.py',), 05:06:55 INFO - 'default_actions': ('clobber', 05:06:55 INFO - 'read-buildbot-config', 05:06:55 INFO - 'download-and-extract', 05:06:55 INFO - 'populate-webroot', 05:06:55 INFO - 'create-virtualenv', 05:06:55 INFO - 'install', 05:06:55 INFO - 'run-tests'), 05:06:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:06:55 INFO - 'download_minidump_stackwalk': True, 05:06:55 INFO - 'download_symbols': 'ondemand', 05:06:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:06:55 INFO - 'tooltool.py': '/tools/tooltool.py', 05:06:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:06:55 INFO - '/tools/misc-python/virtualenv.py')}, 05:06:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:06:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:06:55 INFO - 'installer_path': 'installer.exe', 05:06:55 INFO - 'log_level': 'info', 05:06:55 INFO - 'log_name': 'talos', 05:06:55 INFO - 'log_to_console': True, 05:06:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:06:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:06:55 INFO - 'opt_config_files': (), 05:06:55 INFO - 'pip_index': False, 05:06:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:06:55 INFO - 'cmd': ('bash', 05:06:55 INFO - '-c', 05:06:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:06:55 INFO - 'enabled': True, 05:06:55 INFO - 'halt_on_failure': False, 05:06:55 INFO - 'name': 'check_screen_resolution'},), 05:06:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:06:55 INFO - 'cmd': ('bash', 05:06:55 INFO - '-c', 05:06:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:06:55 INFO - 'enabled': True, 05:06:55 INFO - 'halt_on_failure': False, 05:06:55 INFO - 'name': 'check_screen_resolution'},), 05:06:55 INFO - 'run_cmd_checks_enabled': True, 05:06:55 INFO - 'sps_profile': False, 05:06:55 INFO - 'sps_profile_interval': 0, 05:06:55 INFO - 'suite': 'dromaeojs-e10s', 05:06:55 INFO - 'system_bits': '64', 05:06:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:06:55 INFO - 'title': 't-yosemite-r5-0016', 05:06:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:06:55 INFO - 'use_talos_json': True, 05:06:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:06:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:06:55 INFO - 'work_dir': 'build'} 05:06:55 INFO - ##### 05:06:55 INFO - ##### Running clobber step. 05:06:55 INFO - ##### 05:06:55 INFO - Running pre-action listener: _resource_record_pre_action 05:06:55 INFO - Running main action method: clobber 05:06:55 INFO - rmtree: /builds/slave/test/build 05:06:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:06:59 INFO - Running post-action listener: _resource_record_post_action 05:06:59 INFO - ##### 05:06:59 INFO - ##### Running read-buildbot-config step. 05:06:59 INFO - ##### 05:06:59 INFO - Running pre-action listener: _resource_record_pre_action 05:06:59 INFO - Running main action method: read_buildbot_config 05:06:59 INFO - Using buildbot properties: 05:06:59 INFO - { 05:06:59 INFO - "properties": { 05:06:59 INFO - "buildnumber": 14, 05:06:59 INFO - "product": "firefox", 05:06:59 INFO - "script_repo_revision": "production", 05:06:59 INFO - "builddir": "mozilla-central_yosemite_test-dromaeojs-e10s", 05:06:59 INFO - "repository": "", 05:06:59 INFO - "buildername": "Rev5 MacOSX Yosemite 10.10 mozilla-central talos dromaeojs-e10s", 05:06:59 INFO - "buildid": "20151116030208", 05:06:59 INFO - "slavename": "t-yosemite-r5-0016", 05:06:59 INFO - "stage_platform": "macosx64", 05:06:59 INFO - "basedir": "/builds/slave/test", 05:06:59 INFO - "nightly_build": "True", 05:06:59 INFO - "project": "", 05:06:59 INFO - "platform": "yosemite", 05:06:59 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 05:06:59 INFO - "slavebuilddir": "test", 05:06:59 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:06:59 INFO - "branch": "mozilla-central", 05:06:59 INFO - "repo_path": "mozilla-central", 05:06:59 INFO - "pgo_build": "False", 05:06:59 INFO - "builduid": "1535f0fc9132460b9b4ed37dc4583e08", 05:06:59 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 05:06:59 INFO - }, 05:06:59 INFO - "sourcestamp": { 05:06:59 INFO - "repository": "", 05:06:59 INFO - "hasPatch": false, 05:06:59 INFO - "project": "", 05:06:59 INFO - "branch": "mozilla-central-macosx64-talos", 05:06:59 INFO - "changes": [ 05:06:59 INFO - { 05:06:59 INFO - "category": null, 05:06:59 INFO - "files": [ 05:06:59 INFO - { 05:06:59 INFO - "url": null, 05:06:59 INFO - "name": "https://queue.taskcluster.net/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg" 05:06:59 INFO - } 05:06:59 INFO - ], 05:06:59 INFO - "repository": "", 05:06:59 INFO - "rev": "48d636f678b0e5162ab868dc9024a5ffe350460c", 05:06:59 INFO - "who": "sendchange", 05:06:59 INFO - "when": 1447679164, 05:06:59 INFO - "number": 6665676, 05:06:59 INFO - "comments": "", 05:06:59 INFO - "project": "", 05:06:59 INFO - "at": "Mon 16 Nov 2015 05:06:04", 05:06:59 INFO - "branch": "mozilla-central-macosx64-talos", 05:06:59 INFO - "revlink": "", 05:06:59 INFO - "properties": [ 05:06:59 INFO - [ 05:06:59 INFO - "buildid", 05:06:59 INFO - "20151116030208", 05:06:59 INFO - "Change" 05:06:59 INFO - ], 05:06:59 INFO - [ 05:06:59 INFO - "builduid", 05:06:59 INFO - "1535f0fc9132460b9b4ed37dc4583e08", 05:06:59 INFO - "Change" 05:06:59 INFO - ], 05:06:59 INFO - [ 05:06:59 INFO - "nightly_build", 05:06:59 INFO - "True", 05:06:59 INFO - "Change" 05:06:59 INFO - ], 05:06:59 INFO - [ 05:06:59 INFO - "pgo_build", 05:06:59 INFO - "False", 05:06:59 INFO - "Change" 05:06:59 INFO - ] 05:06:59 INFO - ], 05:06:59 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 05:06:59 INFO - } 05:06:59 INFO - ], 05:06:59 INFO - "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c" 05:06:59 INFO - } 05:06:59 INFO - } 05:06:59 INFO - Found installer url https://queue.taskcluster.net/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg. 05:06:59 INFO - Running post-action listener: _resource_record_post_action 05:06:59 INFO - ##### 05:06:59 INFO - ##### Running download-and-extract step. 05:06:59 INFO - ##### 05:06:59 INFO - Running pre-action listener: _resource_record_pre_action 05:06:59 INFO - Running main action method: download_and_extract 05:06:59 INFO - mkdir: /builds/slave/test/build/tests 05:06:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:06:59 INFO - https://queue.taskcluster.net/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/test_packages.json matches https://queue.taskcluster.net 05:06:59 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/test_packages.json 05:06:59 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/test_packages.json 05:06:59 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/test_packages.json to /builds/slave/test/build/test_packages.json 05:06:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #1 05:07:29 WARNING - Timed out accessing http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/test_packages.json: timed out 05:07:29 INFO - retry: attempt #1 caught exception: timed out 05:07:29 INFO - retry: Failed, sleeping 30 seconds before retrying 05:07:59 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/test_packages.json', 'file_name': '/builds/slave/test/build/test_packages.json'}, attempt #2 05:08:02 INFO - Downloaded 1149 bytes. 05:08:02 INFO - Reading from file /builds/slave/test/build/test_packages.json 05:08:02 INFO - Using the following test package requirements: 05:08:02 INFO - {u'common': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:08:02 INFO - u'cppunittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:08:02 INFO - u'firefox-45.0a1.en-US.mac.cppunittest.tests.zip'], 05:08:02 INFO - u'jittest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:08:02 INFO - u'jsshell-mac.zip'], 05:08:02 INFO - u'mochitest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:08:02 INFO - u'firefox-45.0a1.en-US.mac.mochitest.tests.zip'], 05:08:02 INFO - u'mozbase': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:08:02 INFO - u'reftest': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:08:02 INFO - u'firefox-45.0a1.en-US.mac.reftest.tests.zip'], 05:08:02 INFO - u'talos': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:08:02 INFO - u'firefox-45.0a1.en-US.mac.talos.tests.zip'], 05:08:02 INFO - u'web-platform': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:08:02 INFO - u'firefox-45.0a1.en-US.mac.web-platform.tests.zip'], 05:08:02 INFO - u'webapprt': [u'firefox-45.0a1.en-US.mac.common.tests.zip'], 05:08:02 INFO - u'xpcshell': [u'firefox-45.0a1.en-US.mac.common.tests.zip', 05:08:02 INFO - u'firefox-45.0a1.en-US.mac.xpcshell.tests.zip']} 05:08:02 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:08:02 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:02 INFO - https://queue.taskcluster.net/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:08:02 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:02 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:02 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:02 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:08:04 INFO - Downloaded 17464173 bytes. 05:08:04 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:08:04 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:04 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:08:09 INFO - Return code: 0 05:08:09 INFO - Downloading packages: [u'firefox-45.0a1.en-US.mac.common.tests.zip', u'firefox-45.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:08:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:09 INFO - https://queue.taskcluster.net/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 05:08:09 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:09 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:09 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:08:13 INFO - Downloaded 17464173 bytes. 05:08:13 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] in /builds/slave/test/build/tests 05:08:13 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip 05:08:13 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.common.tests.zip'] with output_timeout 1760 05:08:18 INFO - Return code: 0 05:08: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')]} 05:08:18 INFO - https://queue.taskcluster.net/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 05:08:18 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:08:18 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:08:18 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:08:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:08:20 INFO - Downloaded 11131693 bytes. 05:08:20 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] in /builds/slave/test/build/tests 05:08:20 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip 05:08:20 INFO - Calling ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-45.0a1.en-US.mac.talos.tests.zip'] with output_timeout 1760 05:08:21 INFO - Return code: 0 05:08:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:21 INFO - https://queue.taskcluster.net/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg matches https://queue.taskcluster.net 05:08:21 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:08:21 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:08:21 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg 05:08:21 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg'}, attempt #1 05:08:30 INFO - Downloaded 108782264 bytes. 05:08:30 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:08:30 INFO - mkdir: /builds/slave/test/properties 05:08:30 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:08:30 INFO - Writing to file /builds/slave/test/properties/build_url 05:08:30 INFO - Contents: 05:08:30 INFO - build_url:https://queue.taskcluster.net/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg 05:08:30 INFO - Running post-action listener: _resource_record_post_action 05:08:30 INFO - Running post-action listener: set_extra_try_arguments 05:08:30 INFO - ##### 05:08:30 INFO - ##### Running populate-webroot step. 05:08:30 INFO - ##### 05:08:30 INFO - Running pre-action listener: _resource_record_pre_action 05:08:30 INFO - Running main action method: populate_webroot 05:08:30 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:08:30 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:08:30 INFO - 'remote-trobocheck2': {'talos_options': ['--fennecIDs', 05:08:30 INFO - '../fennec_ids.txt'], 05:08:30 INFO - 'tests': ['tcheck2']}, 05:08:30 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:08:30 INFO - '--tppagecycles', 05:08:30 INFO - '7'], 05:08:30 INFO - 'tests': ['tsvgm']}}, 05:08:30 INFO - 'suites': {'chromez': {'tests': ['tresize', 'tcanvasmark']}, 05:08:30 INFO - 'chromez-e10s': {'talos_options': ['--e10s'], 05:08:30 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:08:30 INFO - 'dromaeojs': {'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:08:30 INFO - 'dromaeojs-e10s': {'talos_options': ['--e10s'], 05:08:30 INFO - 'tests': ['dromaeo_css', 'kraken', 'v8_7']}, 05:08:30 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:30 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:30 INFO - 'talos_options': ['--e10s'], 05:08:30 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:08:30 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:30 INFO - 'tests': ['damp', 'tps']}, 05:08:30 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:30 INFO - 'talos_options': ['--e10s'], 05:08:30 INFO - 'tests': ['damp', 'tps']}, 05:08:30 INFO - 'g3': {'tests': ['dromaeo_dom']}, 05:08:30 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:08:30 INFO - 'other': {'tests': ['a11yr', 05:08:30 INFO - 'ts_paint', 05:08:30 INFO - 'tpaint', 05:08:30 INFO - 'sessionrestore', 05:08:30 INFO - 'sessionrestore_no_auto_restore']}, 05:08:30 INFO - 'other-e10s': {'talos_options': ['--e10s'], 05:08:30 INFO - 'tests': ['a11yr', 05:08:30 INFO - 'ts_paint', 05:08:30 INFO - 'tpaint', 05:08:30 INFO - 'sessionrestore', 05:08:30 INFO - 'sessionrestore_no_auto_restore']}, 05:08:30 INFO - 'other-e10s_l64': {'talos_options': ['--e10s'], 05:08:30 INFO - 'tests': ['a11yr', 05:08:30 INFO - 'ts_paint', 05:08:30 INFO - 'tpaint', 05:08:30 INFO - 'sessionrestore', 05:08:30 INFO - 'sessionrestore_no_auto_restore']}, 05:08:30 INFO - 'other-e10s_nol64': {'talos_options': ['--e10s'], 05:08:30 INFO - 'tests': ['a11yr', 05:08:30 INFO - 'ts_paint', 05:08:30 INFO - 'tpaint', 05:08:30 INFO - 'sessionrestore', 05:08:30 INFO - 'sessionrestore_no_auto_restore']}, 05:08:30 INFO - 'other_l64': {'tests': ['a11yr', 05:08:30 INFO - 'ts_paint', 05:08:30 INFO - 'tpaint', 05:08:30 INFO - 'sessionrestore', 05:08:30 INFO - 'sessionrestore_no_auto_restore']}, 05:08:30 INFO - 'other_nol64': {'tests': ['a11yr', 05:08:30 INFO - 'ts_paint', 05:08:30 INFO - 'tpaint', 05:08:30 INFO - 'sessionrestore', 05:08:30 INFO - 'sessionrestore_no_auto_restore']}, 05:08:30 INFO - 'svgr': {'tests': ['tsvgx', 05:08:30 INFO - 'tsvgr_opacity', 05:08:30 INFO - 'tart', 05:08:30 INFO - 'tscrollx', 05:08:30 INFO - 'cart']}, 05:08:30 INFO - 'svgr-e10s': {'talos_options': ['--e10s'], 05:08:30 INFO - 'tests': ['tsvgx', 05:08:30 INFO - 'tsvgr_opacity', 05:08:30 INFO - 'tart', 05:08:30 INFO - 'tscrollx', 05:08:30 INFO - 'cart']}, 05:08:30 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:30 INFO - 'tests': ['tp5o']}, 05:08:30 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:30 INFO - 'talos_options': ['--e10s'], 05:08:30 INFO - 'tests': ['tp5o']}, 05:08:30 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:30 INFO - 'talos_options': ['--xperf_path', 05:08:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:30 INFO - 'tests': ['tp5n']}, 05:08:30 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 05:08:30 INFO - 'talos_options': ['--e10s', 05:08:30 INFO - '--xperf_path', 05:08:30 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:08:30 INFO - 'tests': ['tp5n']}}, 05:08:30 INFO - 'talos.zip': {'path': '', 05:08:30 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:08:30 INFO - Running post-action listener: _resource_record_post_action 05:08:30 INFO - ##### 05:08:30 INFO - ##### Running create-virtualenv step. 05:08:30 INFO - ##### 05:08:30 INFO - Running pre-action listener: _resource_record_pre_action 05:08:30 INFO - Running main action method: create_virtualenv 05:08:30 INFO - Creating virtualenv /builds/slave/test/build/venv 05:08:30 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:08:30 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:08:31 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:08:31 INFO - Using real prefix '/tools/python27' 05:08:31 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:08:32 INFO - Installing distribute.............................................................................................................................................................................................done. 05:08:35 INFO - Installing pip.................done. 05:08:35 INFO - Return code: 0 05:08:35 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:35 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:35 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:35 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:35 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:35 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:35 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--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 0x10ebc1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa249d226f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eae49f0>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ead88c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7hzUsvsY7o/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.nba8VR1VON/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:35 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:08:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:08:35 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7hzUsvsY7o/Render', 05:08:35 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:35 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:35 INFO - 'HOME': '/Users/cltbld', 05:08:35 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:35 INFO - 'LOGNAME': 'cltbld', 05:08:35 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:35 INFO - 'MOZ_NO_REMOTE': '1', 05:08:35 INFO - 'NO_EM_RESTART': '1', 05:08:35 INFO - 'PAGER': '/bin/cat', 05:08:35 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:35 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:35 INFO - 'PWD': '/builds/slave/test', 05:08:35 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:35 INFO - 'SHELL': '/bin/bash', 05:08:35 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nba8VR1VON/Listeners', 05:08:35 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 05:08:35 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:35 INFO - 'USER': 'cltbld', 05:08:35 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:35 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:35 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:35 INFO - 'XPC_FLAGS': '0x0', 05:08:35 INFO - 'XPC_SERVICE_NAME': '0', 05:08:35 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:36 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:08:36 INFO - Cleaning up... 05:08:36 INFO - Return code: 0 05:08:36 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:36 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10ebc1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa249d226f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eae49f0>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ead88c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7hzUsvsY7o/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.nba8VR1VON/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:36 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=0.7.1'] in /builds/slave/test/build 05:08:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=0.7.1 05:08:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7hzUsvsY7o/Render', 05:08:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:36 INFO - 'HOME': '/Users/cltbld', 05:08:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:36 INFO - 'LOGNAME': 'cltbld', 05:08:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:36 INFO - 'MOZ_NO_REMOTE': '1', 05:08:36 INFO - 'NO_EM_RESTART': '1', 05:08:36 INFO - 'PAGER': '/bin/cat', 05:08:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:36 INFO - 'PWD': '/builds/slave/test', 05:08:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:36 INFO - 'SHELL': '/bin/bash', 05:08:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nba8VR1VON/Listeners', 05:08:36 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 05:08:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:36 INFO - 'USER': 'cltbld', 05:08:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:36 INFO - 'XPC_FLAGS': '0x0', 05:08:36 INFO - 'XPC_SERVICE_NAME': '0', 05:08:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:08:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:36 INFO - Downloading/unpacking psutil>=0.7.1 05:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:38 INFO - Creating supposed download cache at /builds/slave/test/build/venv/cache 05:08:38 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fpsutil-3.1.1.tar.gz 05:08:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:08:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:39 INFO - Installing collected packages: psutil 05:08:39 INFO - Running setup.py install for psutil 05:08:39 INFO - building 'psutil._psutil_osx' extension 05:08:39 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:08:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:08:41 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:08:41 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:08:42 INFO - building 'psutil._psutil_posix' extension 05:08:42 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:08:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:08:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:08:42 INFO - ^ 05:08:42 INFO - 1 warning generated. 05:08:42 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:08:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:08:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:08:42 INFO - Successfully installed psutil 05:08:42 INFO - Cleaning up... 05:08:42 INFO - Return code: 0 05:08:42 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 05:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:42 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:42 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:42 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:42 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10ebc1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa249d226f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eae49f0>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ead88c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7hzUsvsY7o/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.nba8VR1VON/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:42 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.0.0'] in /builds/slave/test/build 05:08:42 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.0.0 05:08:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7hzUsvsY7o/Render', 05:08:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:42 INFO - 'HOME': '/Users/cltbld', 05:08:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:42 INFO - 'LOGNAME': 'cltbld', 05:08:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:42 INFO - 'MOZ_NO_REMOTE': '1', 05:08:42 INFO - 'NO_EM_RESTART': '1', 05:08:42 INFO - 'PAGER': '/bin/cat', 05:08:42 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:42 INFO - 'PWD': '/builds/slave/test', 05:08:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:42 INFO - 'SHELL': '/bin/bash', 05:08:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nba8VR1VON/Listeners', 05:08:42 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 05:08:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:42 INFO - 'USER': 'cltbld', 05:08:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:42 INFO - 'XPC_FLAGS': '0x0', 05:08:42 INFO - 'XPC_SERVICE_NAME': '0', 05:08:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:08:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:42 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 05:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:45 INFO - Downloading mozsystemmonitor-0.0.tar.gz 05:08:45 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fmozsystemmonitor-0.0.tar.gz 05:08:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:08:45 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 05:08:45 INFO - Installing collected packages: mozsystemmonitor 05:08:45 INFO - Running setup.py install for mozsystemmonitor 05:08:45 INFO - Successfully installed mozsystemmonitor 05:08:45 INFO - Cleaning up... 05:08:45 INFO - Return code: 0 05:08:45 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:45 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:45 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:45 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:45 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:45 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 0x10ebc1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa249d226f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eae49f0>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ead88c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7hzUsvsY7o/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.nba8VR1VON/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:45 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:08:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:08:45 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7hzUsvsY7o/Render', 05:08:45 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:45 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:45 INFO - 'HOME': '/Users/cltbld', 05:08:45 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:45 INFO - 'LOGNAME': 'cltbld', 05:08:45 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:45 INFO - 'MOZ_NO_REMOTE': '1', 05:08:45 INFO - 'NO_EM_RESTART': '1', 05:08:45 INFO - 'PAGER': '/bin/cat', 05:08:45 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:45 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:45 INFO - 'PWD': '/builds/slave/test', 05:08:45 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:45 INFO - 'SHELL': '/bin/bash', 05:08:45 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nba8VR1VON/Listeners', 05:08:45 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 05:08:45 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:45 INFO - 'USER': 'cltbld', 05:08:45 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:45 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:45 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:45 INFO - 'XPC_FLAGS': '0x0', 05:08:45 INFO - 'XPC_SERVICE_NAME': '0', 05:08:45 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:08:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:45 INFO - Downloading/unpacking blobuploader==1.2.4 05:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:48 INFO - Downloading blobuploader-1.2.4.tar.gz 05:08:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblobuploader-1.2.4.tar.gz 05:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:08:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:48 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Frequests-1.2.3.tar.gz 05:08:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:08:48 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:48 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:48 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:08:48 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:08:48 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:08:49 INFO - Downloading docopt-0.6.1.tar.gz 05:08:49 INFO - Storing download in cache at ./venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fdocopt-0.6.1.tar.gz 05:08:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:08:49 INFO - Installing collected packages: blobuploader, requests, docopt 05:08:49 INFO - Running setup.py install for blobuploader 05:08:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:08:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:08:49 INFO - Running setup.py install for requests 05:08:50 INFO - Running setup.py install for docopt 05:08:50 INFO - Successfully installed blobuploader requests docopt 05:08:50 INFO - Cleaning up... 05:08:50 INFO - Return code: 0 05:08:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08: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')]} 05:08:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08: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')]} 05:08:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:50 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 0x10ebc1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa249d226f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eae49f0>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ead88c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7hzUsvsY7o/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.nba8VR1VON/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:50 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:08:50 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:08:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7hzUsvsY7o/Render', 05:08:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:50 INFO - 'HOME': '/Users/cltbld', 05:08:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:50 INFO - 'LOGNAME': 'cltbld', 05:08:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:50 INFO - 'MOZ_NO_REMOTE': '1', 05:08:50 INFO - 'NO_EM_RESTART': '1', 05:08:50 INFO - 'PAGER': '/bin/cat', 05:08:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:50 INFO - 'PWD': '/builds/slave/test', 05:08:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:50 INFO - 'SHELL': '/bin/bash', 05:08:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nba8VR1VON/Listeners', 05:08:50 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 05:08:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:50 INFO - 'USER': 'cltbld', 05:08:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:50 INFO - 'XPC_FLAGS': '0x0', 05:08:50 INFO - 'XPC_SERVICE_NAME': '0', 05:08:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:08:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:50 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-RUIfsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:50 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-Ozm93O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:50 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-y3oaV8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:51 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-_qbGRL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:51 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-LKhfb8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:51 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-X7Jxid-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:51 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-XugYnE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:51 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-Awslty-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:51 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-bTWT4p-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:51 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-ckKNBv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:51 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-PSdWDf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:51 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-9EmVpZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:52 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-qrGTaF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:52 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-2zbG_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:52 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-RpCTzt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:52 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-vTzZH4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:52 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-aMEco7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:08:52 INFO - Running setup.py install for manifestparser 05:08:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:08:52 INFO - Running setup.py install for mozcrash 05:08:52 INFO - Running setup.py install for mozdebug 05:08:53 INFO - Running setup.py install for mozdevice 05:08:53 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:08:53 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:08:53 INFO - Running setup.py install for mozfile 05:08:53 INFO - Running setup.py install for mozhttpd 05:08:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:08:53 INFO - Running setup.py install for mozinfo 05:08:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:08:53 INFO - Running setup.py install for mozInstall 05:08:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:08:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:08:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:08:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:08:53 INFO - Running setup.py install for mozleak 05:08:54 INFO - Running setup.py install for mozlog 05:08:54 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:08:54 INFO - Running setup.py install for moznetwork 05:08:54 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:08:54 INFO - Running setup.py install for mozprocess 05:08:54 INFO - Running setup.py install for mozprofile 05:08:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:08:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:08:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:08:54 INFO - Running setup.py install for mozrunner 05:08:55 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Running setup.py install for mozscreenshot 05:08:55 INFO - Running setup.py install for moztest 05:08:55 INFO - Running setup.py install for mozversion 05:08:55 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:08:55 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:08:55 INFO - Cleaning up... 05:08:55 INFO - Return code: 0 05:08:55 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:55 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:08:55 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:55 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:08:55 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:08:55 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:08:55 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 0x10ebc1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa249d226f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eae49f0>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ead88c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7hzUsvsY7o/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.nba8VR1VON/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:08:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:08:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:08:55 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7hzUsvsY7o/Render', 05:08:55 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:08:55 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:08:55 INFO - 'HOME': '/Users/cltbld', 05:08:55 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:08:55 INFO - 'LOGNAME': 'cltbld', 05:08:55 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:08:55 INFO - 'MOZ_NO_REMOTE': '1', 05:08:55 INFO - 'NO_EM_RESTART': '1', 05:08:55 INFO - 'PAGER': '/bin/cat', 05:08:55 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:08:55 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:08:55 INFO - 'PWD': '/builds/slave/test', 05:08:55 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:08:55 INFO - 'SHELL': '/bin/bash', 05:08:55 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nba8VR1VON/Listeners', 05:08:55 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 05:08:55 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:08:55 INFO - 'USER': 'cltbld', 05:08:55 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:08:55 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:08:55 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:08:55 INFO - 'XPC_FLAGS': '0x0', 05:08:55 INFO - 'XPC_SERVICE_NAME': '0', 05:08:55 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:08:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:08:55 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-Ip3PxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:08:55 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:08:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:08:56 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-wdcOnA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.16 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:08:56 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-nSzI5I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:08:56 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-5w0__N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.47 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:08:56 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-bIXV27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:08:56 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-coX5Q5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:08:56 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-j6IYcs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:08:56 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-mBZOC4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:08:56 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-UDNcqF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:08:56 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:08:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:08:56 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-g6CAhg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.0 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:08:57 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-ddVzO1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:08:57 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-j3k7jL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.22 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:08:57 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-Kk2cWo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.27 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:08:57 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-ks6UEP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.11 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:57 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-92milx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:08:57 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-W4xBF2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:08:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:08:57 INFO - Running setup.py (path:/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/pip-l0f83W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.16->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:57 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.47->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:08:57 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:08: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 05:09:00 INFO - Downloading blessings-1.5.1.tar.gz 05:09:00 INFO - Storing download in cache at /builds/slave/test/build/venv/cache/http%3A%2F%2Fpypi.pvt.build.mozilla.org%2Fpub%2Fblessings-1.5.1.tar.gz 05:09:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:09:00 INFO - Installing collected packages: blessings 05:09:00 INFO - Running setup.py install for blessings 05:09:00 INFO - Successfully installed blessings 05:09:00 INFO - Cleaning up... 05:09:00 INFO - Return code: 0 05:09:00 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:09:00 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:01 INFO - Reading from file tmpfile_stdout 05:09:01 INFO - Current package versions: 05:09:01 INFO - blessings == 1.5.1 05:09:01 INFO - blobuploader == 1.2.4 05:09:01 INFO - docopt == 0.6.1 05:09:01 INFO - manifestparser == 1.1 05:09:01 INFO - mozInstall == 1.12 05:09:01 INFO - mozcrash == 0.16 05:09:01 INFO - mozdebug == 0.1 05:09:01 INFO - mozdevice == 0.47 05:09:01 INFO - mozfile == 1.2 05:09:01 INFO - mozhttpd == 0.7 05:09:01 INFO - mozinfo == 0.9 05:09:01 INFO - mozleak == 0.1 05:09:01 INFO - mozlog == 3.0 05:09:01 INFO - moznetwork == 0.27 05:09:01 INFO - mozprocess == 0.22 05:09:01 INFO - mozprofile == 0.27 05:09:01 INFO - mozrunner == 6.11 05:09:01 INFO - mozscreenshot == 0.1 05:09:01 INFO - mozsystemmonitor == 0.0 05:09:01 INFO - moztest == 0.7 05:09:01 INFO - mozversion == 1.4 05:09:01 INFO - psutil == 3.1.1 05:09:01 INFO - requests == 1.2.3 05:09:01 INFO - wsgiref == 0.1.2 05:09:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:09: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')]} 05:09:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:09:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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')]} 05:09:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:09:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:09: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', '-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 0x10ebc1490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eb9e228>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa249d226f0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10eae49f0>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ead88c8>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'HOME': '/Users/cltbld', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7hzUsvsY7o/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.nba8VR1VON/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:09:01 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--download-cache', '/builds/slave/test/build/venv/cache', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --download-cache /builds/slave/test/build/venv/cache --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:09:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7hzUsvsY7o/Render', 05:09:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:01 INFO - 'HOME': '/Users/cltbld', 05:09:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:01 INFO - 'LOGNAME': 'cltbld', 05:09:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:01 INFO - 'MOZ_NO_REMOTE': '1', 05:09:01 INFO - 'NO_EM_RESTART': '1', 05:09:01 INFO - 'PAGER': '/bin/cat', 05:09:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:01 INFO - 'PWD': '/builds/slave/test', 05:09:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:01 INFO - 'SHELL': '/bin/bash', 05:09:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nba8VR1VON/Listeners', 05:09:01 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 05:09:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:01 INFO - 'USER': 'cltbld', 05:09:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:01 INFO - 'XPC_FLAGS': '0x0', 05:09:01 INFO - 'XPC_SERVICE_NAME': '0', 05:09:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:09:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:09:01 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.0->mozcrash>=0.15->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:09:01 INFO - Cleaning up... 05:09:01 INFO - Return code: 0 05:09:01 INFO - Running post-action listener: _resource_record_post_action 05:09:01 INFO - Running post-action listener: _start_resource_monitoring 05:09:01 INFO - Starting resource monitoring. 05:09:01 INFO - ##### 05:09:01 INFO - ##### Running install step. 05:09:01 INFO - ##### 05:09:01 INFO - Running pre-action listener: _resource_record_pre_action 05:09:01 INFO - Running main action method: install 05:09:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:09:01 INFO - Reading from file tmpfile_stdout 05:09:01 INFO - Detecting whether we're running mozinstall >=1.0... 05:09:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:09:01 INFO - Reading from file tmpfile_stdout 05:09:01 INFO - Output received: 05:09:01 INFO - Usage: mozinstall [options] installer 05:09:01 INFO - Options: 05:09:01 INFO - -h, --help show this help message and exit 05:09:01 INFO - -d DEST, --destination=DEST 05:09:01 INFO - Directory to install application into. [default: 05:09:01 INFO - "/builds/slave/test"] 05:09:01 INFO - --app=APP Application being installed. [default: firefox] 05:09:01 INFO - mkdir: /builds/slave/test/build/application 05:09:01 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:09:01 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-45.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:09:39 INFO - Reading from file tmpfile_stdout 05:09:39 INFO - Output received: 05:09:39 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:09:39 INFO - Running post-action listener: _resource_record_post_action 05:09:39 INFO - ##### 05:09:39 INFO - ##### Running run-tests step. 05:09:39 INFO - ##### 05:09:39 INFO - Running pre-action listener: _resource_record_pre_action 05:09:39 INFO - Running main action method: run_tests 05:09:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:09:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:09:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:09:39 INFO - 2015-11-16 05:09:39.410 screenresolution[1631:8678] starting screenresolution argv=screenresolution get 05:09:39 INFO - 2015-11-16 05:09:39.413 screenresolution[1631:8678] Display 0: 1600x1200x32@60 05:09:39 INFO - 2015-11-16 05:09:39.420 screenresolution[1632:8680] starting screenresolution argv=screenresolution list 05:09:39 INFO - Available Modes on Display 0 05:09:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:09:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:09:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:09:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:09:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:09:39 INFO - Intel HD Graphics 3000: 05:09:39 INFO - Chipset Model: Intel HD Graphics 3000 05:09:39 INFO - Type: GPU 05:09:39 INFO - Bus: Built-In 05:09:39 INFO - VRAM (Total): 512 MB 05:09:39 INFO - VRAM (Dynamic, Max): 10 05:09:39 INFO - Vendor: Intel (0x8086) 05:09:39 INFO - Device ID: 0x0116 05:09:39 INFO - Revision ID: 0x0009 05:09:39 INFO - Displays: 05:09:39 INFO - Display: 05:09:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:09:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:09:39 INFO - Display Serial Number: 1600x1200 60 05:09:39 INFO - Main Display: Yes 05:09:39 INFO - Mirror: Off 05:09:39 INFO - Online: Yes 05:09:39 INFO - Rotation: Supported 05:09:39 INFO - Return code: 0 05:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:09:39 INFO - Python 2.7.3 05:09:39 INFO - Return code: 0 05:09:39 INFO - grabbing minidump binary from tooltool 05:09:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 05:09:39 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 0x10eae49f0>, '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 0x10e844db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ead88c8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:09:39 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:09:39 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:09:39 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:09:39 INFO - Return code: 0 05:09:39 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:09:39 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:09:39 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:09:39 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:09:39 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:09:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0016', '--webServer', 'localhost'] in /builds/slave/test/build 05:09:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --debug --branchName Firefox --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r5-0016 --webServer localhost 05:09:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.7hzUsvsY7o/Render', 05:09:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:09:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:09:39 INFO - 'HOME': '/Users/cltbld', 05:09:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:09:39 INFO - 'LOGNAME': 'cltbld', 05:09:39 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:09:39 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:09:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:09:39 INFO - 'MOZ_NO_REMOTE': '1', 05:09:39 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:09:39 INFO - 'NO_EM_RESTART': '1', 05:09:39 INFO - 'PAGER': '/bin/cat', 05:09:39 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:09:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:09:39 INFO - 'PWD': '/builds/slave/test', 05:09:39 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:09:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:09:39 INFO - 'SHELL': '/bin/bash', 05:09:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.nba8VR1VON/Listeners', 05:09:39 INFO - 'TMPDIR': '/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/', 05:09:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:09:39 INFO - 'USER': 'cltbld', 05:09:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:09:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:09:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:09:39 INFO - 'XPC_FLAGS': '0x0', 05:09:39 INFO - 'XPC_SERVICE_NAME': '0', 05:09:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0x0:0x0'} 05:09:39 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--debug', '--branchName', 'Firefox', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r5-0016', '--webServer', 'localhost'] with output_timeout 3600 05:09:40 INFO - mozversion INFO | application_buildid: 20151116030208 05:09:40 INFO - mozversion INFO | application_changeset: 48d636f678b0e5162ab868dc9024a5ffe350460c 05:09:40 INFO - mozversion INFO | application_display_name: Nightly 05:09:40 INFO - mozversion INFO | application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:09:40 INFO - mozversion INFO | application_name: Firefox 05:09:40 INFO - mozversion INFO | application_remotingname: firefox 05:09:40 INFO - mozversion INFO | application_repository: https://hg.mozilla.org/mozilla-central 05:09:40 INFO - mozversion INFO | application_vendor: Mozilla 05:09:40 INFO - mozversion INFO | application_version: 45.0a1 05:09:40 INFO - mozversion INFO | platform_buildid: 20151116030208 05:09:40 INFO - mozversion INFO | platform_changeset: 48d636f678b0e5162ab868dc9024a5ffe350460c 05:09:40 INFO - mozversion INFO | platform_repository: https://hg.mozilla.org/mozilla-central 05:09:40 INFO - mozversion INFO | platform_version: 45.0a1 05:09:40 INFO - 2015-11-16 05:09:40,135 DEBUG : using testdate: 1447679380 05:09:40 INFO - 2015-11-16 05:09:40,136 DEBUG : actual date: 1447679380 05:09:40 INFO - 2015-11-16 05:09:40,145 INFO : starting webserver on 'localhost:49274' 05:09:40 INFO - 2015-11-16 05:09:40,146 INFO : Starting test suite t-yosemite-r5-0016.e 05:09:40 INFO - 2015-11-16 05:09:40,146 INFO : Starting test dromaeo_css 05:09:40 INFO - 2015-11-16 05:09:40,146 DEBUG : operating with platform_type : mac_ 05:09:40 INFO - 2015-11-16 05:09:40,147 INFO : Initialising browser for dromaeo_css test... 05:09:40 INFO - 2015-11-16 05:09:40,162 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmpS971_3/profile http://localhost:49274/getInfo.html 05:09:45 INFO - 2015-11-16 05:09:45,304 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:09:45 INFO - 2015-11-16 05:09:45,304 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:09:45 INFO - 2015-11-16 05:09:45,304 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 05:09:45 INFO - 2015-11-16 05:09:45,304 DEBUG : BROWSER_OUTPUT: __metrics 05:09:45 INFO - 2015-11-16 05:09:45,966 INFO : Browser initialized. 05:09:45 INFO - 2015-11-16 05:09:45,966 INFO : Running cycle 1/1 for dromaeo_css test... 05:09:45 INFO - 2015-11-16 05:09:45,967 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmpS971_3/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:09:58 INFO - 2015-11-16 05:09:58,054 DEBUG : BROWSER_OUTPUT: RSS: Main: 240414720 05:09:58 INFO - 2015-11-16 05:09:58,054 DEBUG : BROWSER_OUTPUT: 05:10:47 INFO - 2015-11-16 05:10:47,902 DEBUG : BROWSER_OUTPUT: 1447679447901 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 05:12:57 INFO - 2015-11-16 05:12:57,898 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49274/tests/dromaeo/cssquery-ext.html) 05:12:59 INFO - 2015-11-16 05:12:59,026 DEBUG : BROWSER_OUTPUT: RSS: Main: 265596928 05:12:59 INFO - 2015-11-16 05:12:59,026 DEBUG : BROWSER_OUTPUT: 05:16:01 INFO - 2015-11-16 05:16:01,098 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-ext.html (next: http://localhost:49274/tests/dromaeo/cssquery-jquery.html) 05:16:01 INFO - 2015-11-16 05:16:01,684 DEBUG : BROWSER_OUTPUT: RSS: Main: 270581760 05:16:01 INFO - 2015-11-16 05:16:01,684 DEBUG : BROWSER_OUTPUT: 05:19:03 INFO - 2015-11-16 05:19:03,518 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49274/tests/dromaeo/cssquery-mootools.html) 05:19:04 INFO - 2015-11-16 05:19:04,106 DEBUG : BROWSER_OUTPUT: RSS: Main: 275013632 05:19:04 INFO - 2015-11-16 05:19:04,106 DEBUG : BROWSER_OUTPUT: 05:22:05 INFO - 2015-11-16 05:22:05,821 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49274/tests/dromaeo/cssquery-prototype.html) 05:22:06 INFO - 2015-11-16 05:22:06,399 DEBUG : BROWSER_OUTPUT: RSS: Main: 278351872 05:22:06 INFO - 2015-11-16 05:22:06,399 DEBUG : BROWSER_OUTPUT: 05:25:08 INFO - 2015-11-16 05:25:08,986 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49274/tests/dromaeo/cssquery-yui.html) 05:25:09 INFO - 2015-11-16 05:25:09,595 DEBUG : BROWSER_OUTPUT: RSS: Main: 284884992 05:25:09 INFO - 2015-11-16 05:25:09,595 DEBUG : BROWSER_OUTPUT: 05:28:11 INFO - 2015-11-16 05:28:11,905 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/dromaeo/cssquery-yui.html (next: http://localhost:49274/tests/dromaeo/cssquery-dojo.html) 05:28:12 INFO - 2015-11-16 05:28:12,162 DEBUG : BROWSER_OUTPUT: RSS: Main: 288456704 05:28:12 INFO - 2015-11-16 05:28:12,162 DEBUG : BROWSER_OUTPUT: 05:28:12 INFO - 2015-11-16 05:28:12,162 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:28:12 INFO - 2015-11-16 05:28:12,162 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:28:12 INFO - 2015-11-16 05:28:12,162 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:28:12 INFO - 2015-11-16 05:28:12,162 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:28:12 INFO - 2015-11-16 05:28:12,163 DEBUG : BROWSER_OUTPUT: |0;dojo.html;3093.582366380538;3155.179653290144;3231.0629917323977;3265.6897594728507;3303.3888730584836;4996.2006079027315;5122.206058060997;5131.9743401282985;5146.897062058757;5189.714565698894;5001.799928002884;5052.520010598996;5066.847994560169;5145.614078944085;5187.092258854695;4658.2313918203545;4733.59764420023;4788.832390866321;4804.351412559295;4833.661643684926;139.80910262295995;4790.952090479085;4814.9759251203695;4829.661923665345;4853.3690620219495;4764.499727528594;4812.470628230892;4814.903701925942;4859.271109333628;4878.829240976566;4823.975880120612;4830.2513110467935;4855.465898751135;4870.683405578661;4928.088303663798;4630.7453090080035;4690.5778479936625;4751.64362672801;4848.9757551212015;4883.169861123618;4924.679895806797;4957.107720610289;5053.84838454847;5175.637705360627;5291.761870715827;5475.808346707846;5490.917636235459;5493.642913210629;5499.560035197174;5520.1167813149705;5386.757595908193;5513.2005859150195;5524.723763811793;5679.460451257124;5680.204771331975;5163.302954101186;5167.689938603696;5177;5179.792808287664;5230.3985041719925;5534.723263836872;5709.314882214161;5718.199452076629;5737.340205876378;5756.079027355603;5330.9733451332495;5364.356277246756;5367.785288588413;5394.568434525228;5418.972905135528;5418.593605479526;5528.198411230349;5552;5557.638753481011;5590.91613625796;5209.166533354645;5343.412224655285;5444.91832622511;5453.836384908459;5518.641288316247;5333.599980001515;5388.649737767033;5392.703401312887;5398.082326004589;5413.052715774724;4232.111256636079;4246.278132717383;4275.850345237902;4290.528041915387;4321.438213032348;3778.981105094457;3782.8486860525272;3894.4937158169255;3918.5101862267215;3925.980370098131;5216.4522725114075;5247.55395791362;5250.343707036621;5264.368275806851;5305.734713264322;5586.301712285965;5592.021396255639;5620.690862002547;5651;5724.656520608777;4977.1538838397555;5078.847634570969;5117.437081920985;5196.714180720021;5261.3686357637325;4906.435759887588;4908.337374454474;4969.229769385751;4969.552740253394;5057.064443078042;5787.768489260382;5811.244538210006;5828.475437210672;5842.737076831638;5866.853328666817;5375.892482150257;5536.7231638417115;5568.053430916835;5602.635828671123;5746.3966283541295;5780.884382312246;5824.679642619697;5827.854303642273;5840.766369345349;5878.706064696663;5417.918731219113;5504.559635229252;5560.582956278215;5562.360328562268;5570.3315602128005;5509.807156749494;5555.388907220122;5626.156076588544;5642.5485961122195;5680.488756011979;5475.4524547544925;5483.8080667176455;5484.643498172606;5507.476789704971;5514.365847927379;5271.077561426659;5364.731763411735;5400.567954563704;5510.311211098613;5529.778808847601;5301.946980530145;5312.7343632818975;5361.088614935392;5403.7838486460105;5440.075187218104;5347.973260133675;5526.115821468546;5534.861628459321;5537.197106419466;5539.058360078716;5236;5270.262163297065;5342.252084708066;5441.945580544302;5444.673319600836 05:28:12 INFO - 2015-11-16 05:28:12,163 DEBUG : BROWSER_OUTPUT: |1;ext.html;549.8762778374869;551.4513059505791;551.5752870289876;563.7153237615004;568.4372471253457;38192;39096.609033909655;39184.80407597961;39238;39494.80252598733;42112.36831447531;42277.36583951236;42351.57648423515;42381.36427953583;42476.08857601407;8848.2478989286;9011.05383934684;9036.728898133066;9073;9080.545972701339;8863.734087977371;8958.686445974392;9015.909840901573;9016.729498115033;9118.270538356915;8801.383903126753;8905.910940890573;8912.509811960339;8917.509536975464;8928.151825576593;8974.730758077269;9005.594748236344;9048.366614337;9058;9179.403338782959;8774.517401542913;8788.077251888588;8873.11268873114;8930.151635594608;8976.820463590691;38146.80926595377;38824.61175388238;38833.61166388328;38895.41656875149;38956.415653765216;2393.664886915833;2699.91435022971;2984.9403011939858;2992.6408830940427;3552.2540266544056;25724.48551028969;26191.869040654867;26580.73419265802;26806.329841753915;26860.731392686215;2296.1413040764187;2307.90768369265;2320.6286994081033;2331.9067237310487;2402.231285988484;240641;244144;244978;245301;246806;43026.569734302255;43636.56363436388;43722.56277437248;43729.56270437319;56181.157282640794;42343;42515.36226956598;42619.57380426218;42890.78554607269;43187.13625727468;13431.731365372638;13682.384292706853;13694.246816424993;13714.24571648569;13793.172409655454;10625.9468702656;10663.253572250023;10677.733056673645;10783.08343790771;10816.351018938889;13794.586162415144;13818.309084545732;13843.30783460823;13893.374798134108;13957.092788968888;6077.878442431215;6226.813195604139;6276.121343011982;6311.274203466568;6337.686744338375;895.1048951048951;947.8862536495527;1007.8135544924066;1048.3971716263027;1075.6504136155781;27431.314217144332;27952.72047279542;27977.860110699723;28152.85923570369;28166.85916570445;972.6206779356057;994.3884511025667;997.3467378866853;1034.2605037398296;1137.8407023016784;14517.128972261698;14573;14670.413183472541;14698.265086745834;15015.774763378558;287168;298821;301001;301708;308887;52608;53087;53372.46627533675;53441.198382024304;53536.732316338166;1311.5344052861287;1312.173330801589;1318.808772727949;1326.3434599873124;1334.8865346445662;27114.1865744028;27214.746986024846;27650.585241220997;27761.44477110406;27967.44065118727;46236.30645540387;46612;46699;46755.99999999864;46904.765476173765;259964;260797;261294;261500;261688;31487.21281967969;42979.570204298805;44464.777676111415;44508.77745611251;44746.55253447424;42363;42801;43037;43265.35101973536;43551.78224108859;34696.653033469345;35503;35715.28569428545;35936.82031589825;36552;34142;34208.31583368269;34709.65290347064;34737.47893781646;34806.47790283198;35709.82145089258;35971.640283596826;36069.819650901576;36076.81961590175;36630.26739465249;30462.695373045986;30710.539341909443;30753.231169220948;30936.53595196029;30995.380092397576;23415.76584234136;23769.762302377447;24009.279721608378;24061;24192.395190120387 05:28:12 INFO - 2015-11-16 05:28:12,163 DEBUG : BROWSER_OUTPUT: |2;jquery.html;319.8432767943708;323.71027930002646;324.08930904159314;329.82253355520794;336.04898138268703;11390.316581005145;11755.706107347321;16519.339226430944;17154.79916405852;17412.738808917846;11291.378974156418;11301.604443844468;11497.252678575887;11505.309681419121;11545.942270288637;4189.392538081976;4278.35824626307;4291.613754762071;4308;4319.438472998521;4135.813888375015;4167.854125105622;4197.223513649969;4240.469941257343;4245.617894389505;4152.584741525839;4178.143480586473;4270.957290427103;4458.175237581057;4509.706869053517;4322.546132656089;4392.692511524195;4448.466184057934;4469.955300447003;4487.349334346518;3758.9812050939845;3905.511811023622;3906;3911.4523966644692;3919.7452165609143;12483.875161248452;12596.874031259662;12696.74606507874;21862.781372186233;22816.65775013376;2018.0616013553622;2047.4369548374316;2117.28012475759;2130.893455327243;2137.6152292587326;13535.187888726708;13706.109102908378;14017.859821401757;14073.225972571505;14216.857831421657;1664.3093116356697;1669.0403018264547;1740.7562941188244;1765.3203516646056;1801.702719051355;62185.37814621841;64131.35868641347;64183.358166418206;64545.35454645487;64970.3502964969;16314;16507;16604.169791510376;16623.50129496117;16690.082045487616;24044.75955240425;24094;24145.517089658108;24217.63673544898;24267.514649706907;8998.325125615605;9111.863322050174;9149.81700365989;9193.770155746026;9224.077592240856;7624.199459056719;7624.69501219945;7626.771196864103;7665.846683066307;7689.50018248812;7780.066392032879;7925.445218834741;7945.64244608994;7958.562279074707;7994.1606131355375;3271.4765637498363;3323.052929915011;3347.866085356607;3440.552728145325;3458.5849698035895;391.106322054105;394.50686641697877;399.4168513969637;402.8549722100042;414.95228048774777;10438.478076096164;10566.735831604117;10610.20423468243;10614.787704245871;10682.252242342962;389.5520151825367;393.99606003939596;406.92878746219293;408.3507223514626;418.50407267388243;4265.4241677373775;5661.801836935688;5705.5720820938595;5735.369109397963;5788.913166302509;390619;400386;544192;551564;619978;64604.35395646077;67815.3218467809;67884;68107.31892681109;68711.3128868705;409.5085896923644;420.0967918974169;423.7499875073721;424.54997702435514;426.2774597057957;9499.287553433382;9570.090841370336;9642.614295428104;9912.454814984956;9958.601655933682;33400.66599334073;34285.31429371348;34833.12917177091;34929.825350873085;35306.293874122886;46016;46564.06871862611;46778.29832552446;46920.29619555778;46952.7652361736;7381.667824947997;7465.58939258346;7570.507916985378;7599.772006839804;7622.199669034893;11174.66476005721;11249.831252531056;11469;11531.250468719507;11535.423228838357;9359.344845860724;9697.321187516805;9883.50582470888;9900.603975841173;9938.900610993798;9519.524023798644;9582.760430989003;9615.5672994714;9710.223182145553;9728.17310528613;9799.167070799062;9921.305508614329;10026.849597256192;10046;10180.083792458714;7284.562926224444;7409.444291678254;7459;7466.328030477283;7577.128630207597;9679.70960871175;9707.66023189185;9796.265280104164;9975.501224938578;10197.898021019695 05:28:12 INFO - 2015-11-16 05:28:12,167 DEBUG : BROWSER_OUTPUT: |3;mootools.html;1411.4072089722315;1728.2741248675563;1761.11944027986;1786.0355408079638;1798.667246559387;6842;6966.477514186431;7363.742269020585;7508.812279693004;7536.736214232503;7391.593462359581;7639.236076392358;7699.499532530382;7743.457957942946;7792.103908050576;2150.9892450537727;2197.3517812245345;2202.2952655150357;2203.9338819835352;2216.024949022425;2230.509287956647;2279.555486680098;2280.874551899653;2292.8280378971563;2308.7691230876944;2198.9670154947607;2205.3604454708116;2206.30501392061;2227.131418746682;2242.663600459936;2199.82401407887;2247.6179049561533;2250.5723912456665;2256.909723611062;2276.7950884420484;2261.97738022621;2278.191242109044;2280.441291883483;2287.7712228777154;2291.9770802291932;7623.161452240249;7675.078990521173;7713.267239612228;7732.845343093107;7831.099423566249;4610.147122782262;4754.381930349067;4769.117713223065;4792.664513484023;4794.688345257547;2913.0823790506133;3017.9889736938153;3020.5167173252175;3022.4106299271652;3024.6672865984724;863.1842908451453;871.2594294849391;879.50747581354;892.2371372476568;931.8369285375032;9960.850587241197;9990.20078393734;10063.647772328006;10156.796864062677;10208.89791102087;4285;4302;4376.387305777193;4413.933790993137;4445.5109937907455;8295.751127466187;8327.750167494985;8395.160483951679;8400.075991640915;8403.327733781283;4854.393200849894;4890.462049174588;4923.950760492421;4951.9752401237765;4956.876078098005;4018.216447792652;4053.452783874139;4285.250081235771;4527.773611319487;4538.909221815546;3399.099238701746;3445.707114895212;3498.7026102781037;3509;3538.363094642989;1090.4275255490772;1100.4002818463796;1103.0183137008069;1111.4776055254017;1125.1842414249768;965.5751469353462;981.5386768218925;995.144176008632;1100.2353364411656;1310.960671179866;7251.854962900818;7277.89083163753;7288.380487658503;7351.522151060164;7370.005049318273;1169.7017260598493;1208.4924331780674;1223.525651589832;1227.7728620205291;1238.9132760706843;5675.3757086720425;5685.317761868602;5717.8570535736935;5737.799177028784;5864.149698293723;9240.537973101318;9294.767630809283;9344.205742511827;9345.906540934504;9459.10138536838;9216.953915230515;9231.815363692689;9234.030426805222;9236.630534778667;9291.72124836256;7125.287471252833;7155.177154627285;7251.564906105545;7268.219286274896;7324;7069.505134640526;7184.209736928829;7287.1984081752025;7303.817404564716;7309.707611695472;8035.236652518001;8231.794205144679;8255.298299644357;8256.25693687571;8314.376421768271;8447.91552084496;8503.0221524523;8541.188587084218;8544.316454683487;8588.613512391832;6536.738530458729;6572.638504882086;6635.469162467088;6796.286389929184;6830.487713421613;7221.241769614115;7253.891191632024;7268.127824661075;7397.926020739724;7400.888986665097;6786.660666966731;6851.07510486078;6897.068895699016;6935.618540980295;7061.823454413475;6793.864122717419;6848.452123829982;6858.074159988338;6862.039314496074;6967.268436814062;6440.388163124496;6857.897131542931;6940.479464040318;7020.5787652741;7027.789166325018;6385.521085918667;6417.101605775102;6425.935740642721;6428.710708018057;6434.742610295536;6490.675466226576;6513.73945042193;6551.639659818756;6566.80299591013;6608.074869518176 05:28:12 INFO - 2015-11-16 05:28:12,167 DEBUG : BROWSER_OUTPUT: |4;prototype.html;311.9532070189471;313.4498954335142;314.71361061434095;317.91416317594235;321.0432909928412;6168.167297414848;6248.437640612344;6257.593256438334;6314.652694101828;6370.267419246788;6076.301225359085;6197.628142311453;6258.62448253104;6306.7161977711;6310.305866354709;4723.763811809413;4758.571728544431;4775.80896764129;4780.16347139251;4829.1790395632825;4737.620990320784;4745.311929770181;4769.642276829234;4778.904421911559;4794.352762377087;4563.680542362036;4704.882377940545;4709.340692303081;4712.5758681718635;4735.976320118394;4691.319758635013;4699.0836786826585;4710.199266124733;4731.810727570893;4747.287906813971;3853.691704663648;3955.208958208341;4066.898327541835;4071.4096456013713;4081.8367265309353;6039.124326972608;6039.818805435844;6078.939210607881;6079.848003799896;6085.421884920926;5246.396664383607;5251.2123181523075;5262.631615786897;5307.28351672527;5314.149736042254;6477.773277935296;6479.1901012373455;6494.155759751249;6548.93451065488;6556;4171.457710497616;4311.28863737483;4313.072689371768;4320.330348795942;4328.978355108205;6814;6901.413379862718;6939.167299923991;6949.652517374111;6958.79123626292;4368.7815609219415;4380.9780951095045;4391.494978077562;4393.824247030147;4460.041091165415;4318.827246910151;4460.955390446054;4461.732296062247;4488.573585509372;4488.775561221991;5231.738413079407;5244.895102097937;5254.710990895461;5266.131088370376;5285.577153827761;6538.8365290868105;6544.411003009752;6546.738130474728;6561.737530498822;6623.602583844889;1532.5478983699836;1580.7154712151694;1580.786593809844;1580.8023997000375;1583.7228485015075;996.3274789517047;1007.808516381885;1013.2856336282903;1023.9334443261164;1030.0832259289239;6291.842703932438;6296.118543403927;6305;6318.115463835067;6333.113364129025;6812.046313516112;6814.863702725917;6814.965925170342;6870.931290687029;6894.13823272091;6117.296510901214;6267;6302.527310451735;6316.178896743486;6360.109584658059;3659.7255205859665;3696.4085746281003;3704.0554658562432;3707.796071216109;3739.2521495700967;7004.194517630538;7154.678039488235;7155.785326440215;7228.38558722504;7253.709851605877;7086.468514861406;7116.679749411289;7175.425965922714;7182;7185.101862267216;7031.613261270679;7134.750283740044;7185.461090418239;7207.96396018027;7213.675384607705;6909.654517274217;6916.896246556406;6929.341712537301;6968.059311993019;6990.161180658353;6760.391564759196;6772.0857684212;6792.898106528307;6801.965990170018;6819.556728812611;6884.621345825827;7112.715491380493;7134.643267836484;7168.928310716826;7195.568265904062;4359.738415695068;4364.803583838671;4391.451068616423;4395.670324725722;4428.490723566831;6828.351306625863;6834.658267086726;6842.692078856364;6889.104416425833;6891.620960847202;6370.968145159244;6511.967440162769;6582.045603387578;6617.742628900493;6653.268140504444;6650.935850263934;6659.766908158192;6664.300248474035;6676.6995485202315;6712.765053223114;6487.578307410004;6512.804615861532;6520.673966301571;6526.706298216686;6530.987696906987;6426.325235850169;6667.299933506912;6683.799486015428;6705.865882682417;6735.966320168368;6418.19772528434;6432.35676432353;6456.451201647725;6515.381038801306;6528.967355163194 05:28:12 INFO - 2015-11-16 05:28:12,171 DEBUG : BROWSER_OUTPUT: |5;yui.html;733.8715724748171;739.8520295940813;750.8460765543063;760.623491371771;793.4817603209586;11450.656480305594;11793.941030294836;11862.288262704244;11883.64349069527;12033.819492707595;12370.443330050146;12446.626601201955;12495.31275779834;12507.687307817308;12555;690.3441730356157;691.8028361916855;857.2927334948661;878.9912100879005;885.9855465492008;847.7160151349306;855.6791203298762;866.2160744526213;870.4907629037021;878.3851304087133;904.4708845325459;915.7344370132654;917.4632839788699;918.3112665500875;918.8070505193917;903.9457632542036;911.1344222988188;911.3711539038043;913.9040400757924;917.206616276919;658.1444122640548;672.3310306245318;674.7739507265023;678.5352033856824;681.3391010719594;13183.406746696422;13301.201927884262;13409.798853017213;13452.663683407894;13487.932560337234;11234.21360504765;11311.925367090113;11573.942130289379;11619.825702614384;11678;7921.762347129596;8033.357331413473;8188.385871059694;8213.507189568645;8426.662933482654;3187.2031992002;3230.337780754963;3231.062991732395;3245.2049247934406;3271.8200498972546;47525;47681.523184768055;48159;48876.266855997186;49145.50854491409;8751.168638979287;8805.207531322212;8834.602442890086;8884.777880553038;9094.454332740057;18641.81358186428;18755.812441875405;18756.437306880816;18796.436106916815;18931;6680.699368528428;6681.198256209286;6709.329067093349;6806.55757375769;6887.5178737487895;3731.738778285494;3772.679322257639;3793.089658482;3807.923841523154;3831.63599458051;2865.9713402866123;2911.0539074800777;2921.3865088331263;2932.105707759154;2938.9706102939126;406.29305009284224;407.2587890040158;410.3524349735813;413.6112054668602;414.672408797053;490.33314692018826;523.3562717857058;542.2544001997254;566.7279705741267;574.778710196569;7729.304362607392;8123.634436450374;8197.672093116209;8223.54770487629;8308.70919517814;442.36299728391015;470.77402846633805;532.653775046223;545.2203349210666;613.739160856643;3239.368323177005;3708.554973403209;3846.615338466187;3937.9803100984313;3949.19041596472;51155.209567664955;51580.74209628928;51652;51759.48240517622;51812.22281665778;47167;47895.521044789806;48139.75930120397;48520;48683.26975095376;44756.55243447589;44845;45068.54931450643;45127.77436112799;45679.543204568196;7944.6822127114265;7973.920260797549;7981.960090199512;8016.559089250147;8271.710490132817;33804.32391352209;34339.14152146116;35054.12364690801;35061.649383505835;35076.82461587676;44115.77942110269;44748;45616.31575526304;45765.31352029656;45856.08287834292;6911.5853048817235;7095.3968912643;7138.179109402485;7181.461390395846;7297.781066568012;10684.83972740394;10710.250282480152;10875.456227188452;11208.49561769706;11261.042811360798;9985.850212246967;10143.695689129338;10198.643047493302;10860.131189504662;10940.45297735126;9320.440773553608;9379.155875971195;9543.42739435636;9629.614815407305;9906.851397228904;8983.460992340219;9052.411593246417;10400.11599014062;10434.843477347998;10497.475126243504;8716.912830871865;8734.301255899385;8815.294776417742;8951.28389728807;9444.008379120094;8290.419670622998;8303.709370172015;8620;9132.360734748503;9165.816683666422 05:28:12 INFO - 2015-11-16 05:28:12,171 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:28:12 INFO - 2015-11-16 05:28:12,171 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:28:12 INFO - 2015-11-16 05:28:12,171 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,282 05:28:12 INFO - 2015-11-16 05:28:12,171 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:28:12 INFO - 2015-11-16 05:28:12,172 DEBUG : BROWSER_OUTPUT: __startTimestamp1447680492157__endTimestamp 05:28:12 INFO - 2015-11-16 05:28:12,172 DEBUG : BROWSER_OUTPUT: 05:28:12 INFO - 2015-11-16 05:28:12,172 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:28:12 INFO - 2015-11-16 05:28:12,172 DEBUG : BROWSER_OUTPUT: Number of tests: 6 05:28:12 INFO - 2015-11-16 05:28:12,172 DEBUG : BROWSER_OUTPUT: 05:28:12 INFO - 2015-11-16 05:28:12,172 DEBUG : BROWSER_OUTPUT: [#0] dojo.html Cycles:165 Average:5145.11 Median:5333.60 stddev:675.34 (12.7%) stddev-sans-first:657.95 05:28:12 INFO - 2015-11-16 05:28:12,173 DEBUG : BROWSER_OUTPUT: Values: 3093.6 3155.2 3231.1 3265.7 3303.4 4996.2 5122.2 5132.0 5146.9 5189.7 5001.8 5052.5 5066.8 5145.6 5187.1 4658.2 4733.6 4788.8 4804.4 4833.7 139.8 4791.0 4815.0 4829.7 4853.4 4764.5 4812.5 4814.9 4859.3 4878.8 4824.0 4830.3 4855.5 4870.7 4928.1 4630.7 4690.6 4751.6 4849.0 4883.2 4924.7 4957.1 5053.8 5175.6 5291.8 5475.8 5490.9 5493.6 5499.6 5520.1 5386.8 5513.2 5524.7 5679.5 5680.2 5163.3 5167.7 5177.0 5179.8 5230.4 5534.7 5709.3 5718.2 5737.3 5756.1 5331.0 5364.4 5367.8 5394.6 5419.0 5418.6 5528.2 5552.0 5557.6 5590.9 5209.2 5343.4 5444.9 5453.8 5518.6 5333.6 5388.6 5392.7 5398.1 5413.1 4232.1 4246.3 4275.9 4290.5 4321.4 3779.0 3782.8 3894.5 3918.5 3926.0 5216.5 5247.6 5250.3 5264.4 5305.7 5586.3 5592.0 5620.7 5651.0 5724.7 4977.2 5078.8 5117.4 5196.7 5261.4 4906.4 4908.3 4969.2 4969.6 5057.1 5787.8 5811.2 5828.5 5842.7 5866.9 5375.9 5536.7 5568.1 5602.6 5746.4 5780.9 5824.7 5827.9 5840.8 5878.7 5417.9 5504.6 5560.6 5562.4 5570.3 5509.8 5555.4 5626.2 5642.5 5680.5 5475.5 5483.8 5484.6 5507.5 5514.4 5271.1 5364.7 5400.6 5510.3 5529.8 5301.9 5312.7 5361.1 5403.8 5440.1 5348.0 5526.1 5534.9 5537.2 5539.1 5236.0 5270.3 5342.3 5441.9 5444.7 05:28:12 INFO - 2015-11-16 05:28:12,173 DEBUG : BROWSER_OUTPUT: 05:28:12 INFO - 2015-11-16 05:28:12,173 DEBUG : BROWSER_OUTPUT: [#1] ext.html Cycles:180 Average:43175.39 Median:35954.23 stddev:70238.43 (195.4%) stddev-sans-first:70362.55 05:28:12 INFO - 2015-11-16 05:28:12,174 DEBUG : BROWSER_OUTPUT: Values: 549.9 551.5 551.6 563.7 568.4 38192.0 39096.6 39184.8 39238.0 39494.8 42112.4 42277.4 42351.6 42381.4 42476.1 8848.2 9011.1 9036.7 9073.0 9080.5 8863.7 8958.7 9015.9 9016.7 9118.3 8801.4 8905.9 8912.5 8917.5 8928.2 8974.7 9005.6 9048.4 9058.0 9179.4 8774.5 8788.1 8873.1 8930.2 8976.8 38146.8 38824.6 38833.6 38895.4 38956.4 2393.7 2699.9 2984.9 2992.6 3552.3 25724.5 26191.9 26580.7 26806.3 26860.7 2296.1 2307.9 2320.6 2331.9 2402.2 240641.0 244144.0 244978.0 245301.0 246806.0 43026.6 43636.6 43722.6 43729.6 56181.2 42343.0 42515.4 42619.6 42890.8 43187.1 13431.7 13682.4 13694.2 13714.2 13793.2 10625.9 10663.3 10677.7 10783.1 10816.4 13794.6 13818.3 13843.3 13893.4 13957.1 6077.9 6226.8 6276.1 6311.3 6337.7 895.1 947.9 1007.8 1048.4 1075.7 27431.3 27952.7 27977.9 28152.9 28166.9 972.6 994.4 997.3 1034.3 1137.8 14517.1 14573.0 14670.4 14698.3 15015.8 287168.0 298821.0 301001.0 301708.0 308887.0 52608.0 53087.0 53372.5 53441.2 53536.7 1311.5 1312.2 1318.8 1326.3 1334.9 27114.2 27214.7 27650.6 27761.4 27967.4 46236.3 46612.0 46699.0 46756.0 46904.8 259964.0 260797.0 261294.0 261500.0 261688.0 31487.2 42979.6 44464.8 44508.8 44746.6 42363.0 42801.0 43037.0 43265.4 43551.8 34696.7 35503.0 35715.3 35936.8 36552.0 34142.0 34208.3 34709.7 34737.5 34806.5 35709.8 35971.6 36069.8 36076.8 36630.3 30462.7 30710.5 30753.2 30936.5 30995.4 23415.8 23769.8 24009.3 24061.0 24192.4 05:28:12 INFO - 2015-11-16 05:28:12,175 DEBUG : BROWSER_OUTPUT: 05:28:12 INFO - 2015-11-16 05:28:12,175 DEBUG : BROWSER_OUTPUT: [#2] jquery.html Cycles:180 Average:26589.66 Median:2303.95 stddev:83393.54 (3619.6%) stddev-sans-first:83604.15 05:28:12 INFO - 2015-11-16 05:28:12,176 DEBUG : BROWSER_OUTPUT: Values: 319.8 323.7 324.1 329.8 336.0 11390.3 11755.7 16519.3 17154.8 17412.7 11291.4 11301.6 11497.3 11505.3 11545.9 4189.4 4278.4 4291.6 4308.0 4319.4 4135.8 4167.9 4197.2 4240.5 4245.6 4152.6 4178.1 4271.0 4458.2 4509.7 4322.5 4392.7 4448.5 4470.0 4487.3 3759.0 3905.5 3906.0 3911.5 3919.7 12483.9 12596.9 12696.7 21862.8 22816.7 2018.1 2047.4 2117.3 2130.9 2137.6 13535.2 13706.1 14017.9 14073.2 14216.9 1664.3 1669.0 1740.8 1765.3 1801.7 62185.4 64131.4 64183.4 64545.4 64970.4 16314.0 16507.0 16604.2 16623.5 16690.1 24044.8 24094.0 24145.5 24217.6 24267.5 8998.3 9111.9 9149.8 9193.8 9224.1 7624.2 7624.7 7626.8 7665.8 7689.5 7780.1 7925.4 7945.6 7958.6 7994.2 3271.5 3323.1 3347.9 3440.6 3458.6 391.1 394.5 399.4 402.9 415.0 10438.5 10566.7 10610.2 10614.8 10682.3 389.6 394.0 406.9 408.4 418.5 4265.4 5661.8 5705.6 5735.4 5788.9 390619.0 400386.0 544192.0 551564.0 619978.0 64604.4 67815.3 67884.0 68107.3 68711.3 409.5 420.1 423.7 424.5 426.3 9499.3 9570.1 9642.6 9912.5 9958.6 33400.7 34285.3 34833.1 34929.8 35306.3 46016.0 46564.1 46778.3 46920.3 46952.8 7381.7 7465.6 7570.5 7599.8 7622.2 11174.7 11249.8 11469.0 11531.3 11535.4 9359.3 9697.3 9883.5 9900.6 9938.9 9519.5 9582.8 9615.6 9710.2 9728.2 9799.2 9921.3 10026.8 10046.0 10180.1 7284.6 7409.4 7459.0 7466.3 7577.1 9679.7 9707.7 9796.3 9975.5 10197.9 05:28:12 INFO - 2015-11-16 05:28:12,176 DEBUG : BROWSER_OUTPUT: 05:28:12 INFO - 2015-11-16 05:28:12,176 DEBUG : BROWSER_OUTPUT: [#3] mootools.html Cycles:180 Average:5373.03 Median:6569.72 stddev:2738.22 (41.7%) stddev-sans-first:2729.71 05:28:12 INFO - 2015-11-16 05:28:12,178 DEBUG : BROWSER_OUTPUT: Values: 1411.4 1728.3 1761.1 1786.0 1798.7 6842.0 6966.5 7363.7 7508.8 7536.7 7391.6 7639.2 7699.5 7743.5 7792.1 2151.0 2197.4 2202.3 2203.9 2216.0 2230.5 2279.6 2280.9 2292.8 2308.8 2199.0 2205.4 2206.3 2227.1 2242.7 2199.8 2247.6 2250.6 2256.9 2276.8 2262.0 2278.2 2280.4 2287.8 2292.0 7623.2 7675.1 7713.3 7732.8 7831.1 4610.1 4754.4 4769.1 4792.7 4794.7 2913.1 3018.0 3020.5 3022.4 3024.7 863.2 871.3 879.5 892.2 931.8 9960.9 9990.2 10063.6 10156.8 10208.9 4285.0 4302.0 4376.4 4413.9 4445.5 8295.8 8327.8 8395.2 8400.1 8403.3 4854.4 4890.5 4924.0 4952.0 4956.9 4018.2 4053.5 4285.3 4527.8 4538.9 3399.1 3445.7 3498.7 3509.0 3538.4 1090.4 1100.4 1103.0 1111.5 1125.2 965.6 981.5 995.1 1100.2 1311.0 7251.9 7277.9 7288.4 7351.5 7370.0 1169.7 1208.5 1223.5 1227.8 1238.9 5675.4 5685.3 5717.9 5737.8 5864.1 9240.5 9294.8 9344.2 9345.9 9459.1 9217.0 9231.8 9234.0 9236.6 9291.7 7125.3 7155.2 7251.6 7268.2 7324.0 7069.5 7184.2 7287.2 7303.8 7309.7 8035.2 8231.8 8255.3 8256.3 8314.4 8447.9 8503.0 8541.2 8544.3 8588.6 6536.7 6572.6 6635.5 6796.3 6830.5 7221.2 7253.9 7268.1 7397.9 7400.9 6786.7 6851.1 6897.1 6935.6 7061.8 6793.9 6848.5 6858.1 6862.0 6967.3 6440.4 6857.9 6940.5 7020.6 7027.8 6385.5 6417.1 6425.9 6428.7 6434.7 6490.7 6513.7 6551.6 6566.8 6608.1 05:28:12 INFO - 2015-11-16 05:28:12,178 DEBUG : BROWSER_OUTPUT: 05:28:12 INFO - 2015-11-16 05:28:12,178 DEBUG : BROWSER_OUTPUT: [#4] prototype.html Cycles:180 Average:5488.33 Median:6305.86 stddev:1722.65 (27.3%) stddev-sans-first:1683.10 05:28:12 INFO - 2015-11-16 05:28:12,178 DEBUG : BROWSER_OUTPUT: Values: 312.0 313.4 314.7 317.9 321.0 6168.2 6248.4 6257.6 6314.7 6370.3 6076.3 6197.6 6258.6 6306.7 6310.3 4723.8 4758.6 4775.8 4780.2 4829.2 4737.6 4745.3 4769.6 4778.9 4794.4 4563.7 4704.9 4709.3 4712.6 4736.0 4691.3 4699.1 4710.2 4731.8 4747.3 3853.7 3955.2 4066.9 4071.4 4081.8 6039.1 6039.8 6078.9 6079.8 6085.4 5246.4 5251.2 5262.6 5307.3 5314.1 6477.8 6479.2 6494.2 6548.9 6556.0 4171.5 4311.3 4313.1 4320.3 4329.0 6814.0 6901.4 6939.2 6949.7 6958.8 4368.8 4381.0 4391.5 4393.8 4460.0 4318.8 4461.0 4461.7 4488.6 4488.8 5231.7 5244.9 5254.7 5266.1 5285.6 6538.8 6544.4 6546.7 6561.7 6623.6 1532.5 1580.7 1580.8 1580.8 1583.7 996.3 1007.8 1013.3 1023.9 1030.1 6291.8 6296.1 6305.0 6318.1 6333.1 6812.0 6814.9 6815.0 6870.9 6894.1 6117.3 6267.0 6302.5 6316.2 6360.1 3659.7 3696.4 3704.1 3707.8 3739.3 7004.2 7154.7 7155.8 7228.4 7253.7 7086.5 7116.7 7175.4 7182.0 7185.1 7031.6 7134.8 7185.5 7208.0 7213.7 6909.7 6916.9 6929.3 6968.1 6990.2 6760.4 6772.1 6792.9 6802.0 6819.6 6884.6 7112.7 7134.6 7168.9 7195.6 4359.7 4364.8 4391.5 4395.7 4428.5 6828.4 6834.7 6842.7 6889.1 6891.6 6371.0 6512.0 6582.0 6617.7 6653.3 6650.9 6659.8 6664.3 6676.7 6712.8 6487.6 6512.8 6520.7 6526.7 6531.0 6426.3 6667.3 6683.8 6705.9 6736.0 6418.2 6432.4 6456.5 6515.4 6529.0 05:28:12 INFO - 2015-11-16 05:28:12,178 DEBUG : BROWSER_OUTPUT: 05:28:12 INFO - 2015-11-16 05:28:12,180 DEBUG : BROWSER_OUTPUT: [#5] yui.html Cycles:180 Average:12955.64 Median:51367.98 stddev:15408.75 (30.0%) stddev-sans-first:15424.64 05:28:12 INFO - 2015-11-16 05:28:12,180 DEBUG : BROWSER_OUTPUT: Values: 733.9 739.9 750.8 760.6 793.5 11450.7 11793.9 11862.3 11883.6 12033.8 12370.4 12446.6 12495.3 12507.7 12555.0 690.3 691.8 857.3 879.0 886.0 847.7 855.7 866.2 870.5 878.4 904.5 915.7 917.5 918.3 918.8 903.9 911.1 911.4 913.9 917.2 658.1 672.3 674.8 678.5 681.3 13183.4 13301.2 13409.8 13452.7 13487.9 11234.2 11311.9 11573.9 11619.8 11678.0 7921.8 8033.4 8188.4 8213.5 8426.7 3187.2 3230.3 3231.1 3245.2 3271.8 47525.0 47681.5 48159.0 48876.3 49145.5 8751.2 8805.2 8834.6 8884.8 9094.5 18641.8 18755.8 18756.4 18796.4 18931.0 6680.7 6681.2 6709.3 6806.6 6887.5 3731.7 3772.7 3793.1 3807.9 3831.6 2866.0 2911.1 2921.4 2932.1 2939.0 406.3 407.3 410.4 413.6 414.7 490.3 523.4 542.3 566.7 574.8 7729.3 8123.6 8197.7 8223.5 8308.7 442.4 470.8 532.7 545.2 613.7 3239.4 3708.6 3846.6 3938.0 3949.2 51155.2 51580.7 51652.0 51759.5 51812.2 47167.0 47895.5 48139.8 48520.0 48683.3 44756.6 44845.0 45068.5 45127.8 45679.5 7944.7 7973.9 7982.0 8016.6 8271.7 33804.3 34339.1 35054.1 35061.6 35076.8 44115.8 44748.0 45616.3 45765.3 45856.1 6911.6 7095.4 7138.2 7181.5 7297.8 10684.8 10710.3 10875.5 11208.5 11261.0 9985.9 10143.7 10198.6 10860.1 10940.5 9320.4 9379.2 9543.4 9629.6 9906.9 8983.5 9052.4 10400.1 10434.8 10497.5 8716.9 8734.3 8815.3 8951.3 9444.0 8290.4 8303.7 8620.0 9132.4 9165.8 05:28:12 INFO - 2015-11-16 05:28:12,180 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:28:12 INFO - 2015-11-16 05:28:12,180 DEBUG : BROWSER_OUTPUT: 05:28:12 INFO - 2015-11-16 05:28:12,803 INFO : Browser exited with error code: 0 05:28:12 INFO - 2015-11-16 05:28:12,831 INFO : Completed test dromaeo_css (00:18:32) 05:28:12 INFO - 2015-11-16 05:28:12,831 INFO : Starting test kraken 05:28:12 INFO - 2015-11-16 05:28:12,831 DEBUG : operating with platform_type : mac_ 05:28:12 INFO - 2015-11-16 05:28:12,831 INFO : Initialising browser for kraken test... 05:28:12 INFO - 2015-11-16 05:28:12,844 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmpQbusQe/profile http://localhost:49274/getInfo.html 05:28:15 INFO - 2015-11-16 05:28:15,840 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:28:15 INFO - 2015-11-16 05:28:15,840 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:28:15 INFO - 2015-11-16 05:28:15,841 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 05:28:15 INFO - 2015-11-16 05:28:15,841 DEBUG : BROWSER_OUTPUT: __metrics 05:28:16 INFO - 2015-11-16 05:28:16,528 INFO : Browser initialized. 05:28:16 INFO - 2015-11-16 05:28:16,529 INFO : Running cycle 1/1 for kraken test... 05:28:16 INFO - 2015-11-16 05:28:16,529 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmpQbusQe/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:28:28 INFO - 2015-11-16 05:28:28,553 DEBUG : BROWSER_OUTPUT: RSS: Main: 240156672 05:28:28 INFO - 2015-11-16 05:28:28,554 DEBUG : BROWSER_OUTPUT: 05:28:31 INFO - 2015-11-16 05:28:31,050 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection) 05:28:31 INFO - 2015-11-16 05:28:31,657 DEBUG : BROWSER_OUTPUT: RSS: Main: 259407872 05:28:31 INFO - 2015-11-16 05:28:31,657 DEBUG : BROWSER_OUTPUT: 05:28:34 INFO - 2015-11-16 05:28:34,280 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-dft) 05:28:34 INFO - 2015-11-16 05:28:34,881 DEBUG : BROWSER_OUTPUT: RSS: Main: 267735040 05:28:34 INFO - 2015-11-16 05:28:34,882 DEBUG : BROWSER_OUTPUT: 05:28:37 INFO - 2015-11-16 05:28:37,753 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-fft) 05:28:38 INFO - 2015-11-16 05:28:38,329 DEBUG : BROWSER_OUTPUT: RSS: Main: 267083776 05:28:38 INFO - 2015-11-16 05:28:38,329 DEBUG : BROWSER_OUTPUT: 05:28:40 INFO - 2015-11-16 05:28:40,269 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator) 05:28:40 INFO - 2015-11-16 05:28:40,878 DEBUG : BROWSER_OUTPUT: RSS: Main: 267554816 05:28:40 INFO - 2015-11-16 05:28:40,878 DEBUG : BROWSER_OUTPUT: 05:28:42 INFO - 2015-11-16 05:28:42,995 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:28:43 INFO - 2015-11-16 05:28:43,567 DEBUG : BROWSER_OUTPUT: RSS: Main: 268017664 05:28:43 INFO - 2015-11-16 05:28:43,567 DEBUG : BROWSER_OUTPUT: 05:28:46 INFO - 2015-11-16 05:28:46,632 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom) 05:28:47 INFO - 2015-11-16 05:28:47,214 DEBUG : BROWSER_OUTPUT: RSS: Main: 269213696 05:28:47 INFO - 2015-11-16 05:28:47,214 DEBUG : BROWSER_OUTPUT: 05:28:50 INFO - 2015-11-16 05:28:50,367 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate) 05:28:50 INFO - 2015-11-16 05:28:50,954 DEBUG : BROWSER_OUTPUT: RSS: Main: 267206656 05:28:50 INFO - 2015-11-16 05:28:50,955 DEBUG : BROWSER_OUTPUT: 05:28:53 INFO - 2015-11-16 05:28:53,833 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial) 05:28:54 INFO - 2015-11-16 05:28:54,423 DEBUG : BROWSER_OUTPUT: RSS: Main: 267550720 05:28:54 INFO - 2015-11-16 05:28:54,423 DEBUG : BROWSER_OUTPUT: 05:28:55 INFO - 2015-11-16 05:28:55,990 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:28:56 INFO - 2015-11-16 05:28:56,562 DEBUG : BROWSER_OUTPUT: RSS: Main: 268525568 05:28:56 INFO - 2015-11-16 05:28:56,562 DEBUG : BROWSER_OUTPUT: 05:28:58 INFO - 2015-11-16 05:28:58,402 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:28:59 INFO - 2015-11-16 05:28:59,031 DEBUG : BROWSER_OUTPUT: RSS: Main: 268460032 05:28:59 INFO - 2015-11-16 05:28:59,031 DEBUG : BROWSER_OUTPUT: 05:29:01 INFO - 2015-11-16 05:29:01,117 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:29:01 INFO - 2015-11-16 05:29:01,704 DEBUG : BROWSER_OUTPUT: RSS: Main: 268857344 05:29:01 INFO - 2015-11-16 05:29:01,705 DEBUG : BROWSER_OUTPUT: 05:29:04 INFO - 2015-11-16 05:29:04,325 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:29:04 INFO - 2015-11-16 05:29:04,916 DEBUG : BROWSER_OUTPUT: RSS: Main: 268427264 05:29:04 INFO - 2015-11-16 05:29:04,916 DEBUG : BROWSER_OUTPUT: 05:29:07 INFO - 2015-11-16 05:29:07,572 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:29:08 INFO - 2015-11-16 05:29:08,164 DEBUG : BROWSER_OUTPUT: RSS: Main: 268566528 05:29:08 INFO - 2015-11-16 05:29:08,164 DEBUG : BROWSER_OUTPUT: 05:29:09 INFO - 2015-11-16 05:29:09,876 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49274/tests/kraken/driver.html?testName=ai-astar) 05:29:10 INFO - 2015-11-16 05:29:10,135 DEBUG : BROWSER_OUTPUT: RSS: Main: 269004800 05:29:10 INFO - 2015-11-16 05:29:10,135 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-16 05:29:10,135 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:29:10 INFO - 2015-11-16 05:29:10,135 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:29:10 INFO - 2015-11-16 05:29:10,136 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:29:10 INFO - 2015-11-16 05:29:10,136 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:29:10 INFO - 2015-11-16 05:29:10,136 DEBUG : BROWSER_OUTPUT: |0;ai-astar;108;99;108;108;107;120;109;108;108;108 05:29:10 INFO - 2015-11-16 05:29:10,136 DEBUG : BROWSER_OUTPUT: |1;audio-beat-detection;156;130;152;159;131;151;148;129;162;128 05:29:10 INFO - 2015-11-16 05:29:10,136 DEBUG : BROWSER_OUTPUT: |2;audio-dft;164;165;165;166;168;168;170;172;169;167 05:29:10 INFO - 2015-11-16 05:29:10,136 DEBUG : BROWSER_OUTPUT: |3;audio-fft;75;74;76;66;75;70;70;119;66;69 05:29:10 INFO - 2015-11-16 05:29:10,136 DEBUG : BROWSER_OUTPUT: |4;audio-oscillator;90;90;127;88;90;89;124;88;90;137 05:29:10 INFO - 2015-11-16 05:29:10,137 DEBUG : BROWSER_OUTPUT: |5;imaging-gaussian-blur;121;117;115;115;120;117;117;126;125;129 05:29:10 INFO - 2015-11-16 05:29:10,137 DEBUG : BROWSER_OUTPUT: |6;imaging-darkroom;127;127;128;127;131;128;131;137;135;131 05:29:10 INFO - 2015-11-16 05:29:10,137 DEBUG : BROWSER_OUTPUT: |7;imaging-desaturate;96;108;98;105;98;103;104;113;112;103 05:29:10 INFO - 2015-11-16 05:29:10,137 DEBUG : BROWSER_OUTPUT: |8;json-parse-financial;64;63;63;63;63;62;63;69;62;62 05:29:10 INFO - 2015-11-16 05:29:10,137 DEBUG : BROWSER_OUTPUT: |9;json-stringify-tinderbox;70;72;71;72;70;72;71;73;72;72 05:29:10 INFO - 2015-11-16 05:29:10,137 DEBUG : BROWSER_OUTPUT: |10;stanford-crypto-aes;87;88;85;86;86;89;85;86;93;88 05:29:10 INFO - 2015-11-16 05:29:10,138 DEBUG : BROWSER_OUTPUT: |11;stanford-crypto-ccm;134;134;136;122;135;135;132;139;141;139 05:29:10 INFO - 2015-11-16 05:29:10,138 DEBUG : BROWSER_OUTPUT: |12;stanford-crypto-pbkdf2;155;154;156;160;154;159;159;160;161;165 05:29:10 INFO - 2015-11-16 05:29:10,138 DEBUG : BROWSER_OUTPUT: |13;stanford-crypto-sha256-iterative;71;71;71;71;71;70;72;71;73;72 05:29:10 INFO - 2015-11-16 05:29:10,138 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:29:10 INFO - 2015-11-16 05:29:10,138 DEBUG : BROWSER_OUTPUT: __start_cc_report 05:29:10 INFO - 2015-11-16 05:29:10,139 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_cycle_collect,720 05:29:10 INFO - 2015-11-16 05:29:10,139 DEBUG : BROWSER_OUTPUT: __end_cc_report 05:29:10 INFO - 2015-11-16 05:29:10,139 DEBUG : BROWSER_OUTPUT: __startTimestamp1447680550129__endTimestamp 05:29:10 INFO - 2015-11-16 05:29:10,139 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-16 05:29:10,139 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:29:10 INFO - 2015-11-16 05:29:10,139 DEBUG : BROWSER_OUTPUT: Number of tests: 14 05:29:10 INFO - 2015-11-16 05:29:10,140 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-16 05:29:10,140 DEBUG : BROWSER_OUTPUT: [#0] ai-astar Cycles:10 Average:108.30 Median:108.00 stddev:5.01 (4.6%) stddev-sans-first:5.32 05:29:10 INFO - 2015-11-16 05:29:10,140 DEBUG : BROWSER_OUTPUT: Values: 108.0 99.0 108.0 108.0 107.0 120.0 109.0 108.0 108.0 108.0 05:29:10 INFO - 2015-11-16 05:29:10,140 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-16 05:29:10,140 DEBUG : BROWSER_OUTPUT: [#1] audio-beat-detection Cycles:10 Average:144.60 Median:151.50 stddev:13.60 (9.0%) stddev-sans-first:13.78 05:29:10 INFO - 2015-11-16 05:29:10,140 DEBUG : BROWSER_OUTPUT: Values: 156.0 130.0 152.0 159.0 131.0 151.0 148.0 129.0 162.0 128.0 05:29:10 INFO - 2015-11-16 05:29:10,140 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-16 05:29:10,140 DEBUG : BROWSER_OUTPUT: [#2] audio-dft Cycles:10 Average:167.40 Median:168.00 stddev:2.50 (1.5%) stddev-sans-first:2.33 05:29:10 INFO - 2015-11-16 05:29:10,141 DEBUG : BROWSER_OUTPUT: Values: 164.0 165.0 165.0 166.0 168.0 168.0 170.0 172.0 169.0 167.0 05:29:10 INFO - 2015-11-16 05:29:10,141 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-16 05:29:10,141 DEBUG : BROWSER_OUTPUT: [#3] audio-fft Cycles:10 Average:76.00 Median:72.00 stddev:15.55 (21.6%) stddev-sans-first:16.49 05:29:10 INFO - 2015-11-16 05:29:10,141 DEBUG : BROWSER_OUTPUT: Values: 75.0 74.0 76.0 66.0 75.0 70.0 70.0 119.0 66.0 69.0 05:29:10 INFO - 2015-11-16 05:29:10,141 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-16 05:29:10,141 DEBUG : BROWSER_OUTPUT: [#4] audio-oscillator Cycles:10 Average:101.30 Median:89.50 stddev:19.62 (21.9%) stddev-sans-first:20.38 05:29:10 INFO - 2015-11-16 05:29:10,141 DEBUG : BROWSER_OUTPUT: Values: 90.0 90.0 127.0 88.0 90.0 89.0 124.0 88.0 90.0 137.0 05:29:10 INFO - 2015-11-16 05:29:10,141 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-16 05:29:10,142 DEBUG : BROWSER_OUTPUT: [#5] imaging-gaussian-blur Cycles:10 Average:120.20 Median:120.50 stddev:4.94 (4.1%) stddev-sans-first:5.23 05:29:10 INFO - 2015-11-16 05:29:10,142 DEBUG : BROWSER_OUTPUT: Values: 121.0 117.0 115.0 115.0 120.0 117.0 117.0 126.0 125.0 129.0 05:29:10 INFO - 2015-11-16 05:29:10,142 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-16 05:29:10,142 DEBUG : BROWSER_OUTPUT: [#6] imaging-darkroom Cycles:10 Average:130.20 Median:131.00 stddev:3.52 (2.7%) stddev-sans-first:3.54 05:29:10 INFO - 2015-11-16 05:29:10,142 DEBUG : BROWSER_OUTPUT: Values: 127.0 127.0 128.0 127.0 131.0 128.0 131.0 137.0 135.0 131.0 05:29:10 INFO - 2015-11-16 05:29:10,142 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-16 05:29:10,142 DEBUG : BROWSER_OUTPUT: [#7] imaging-desaturate Cycles:10 Average:104.00 Median:112.50 stddev:5.77 (5.1%) stddev-sans-first:5.35 05:29:10 INFO - 2015-11-16 05:29:10,142 DEBUG : BROWSER_OUTPUT: Values: 96.0 108.0 98.0 105.0 98.0 103.0 104.0 113.0 112.0 103.0 05:29:10 INFO - 2015-11-16 05:29:10,142 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-16 05:29:10,142 DEBUG : BROWSER_OUTPUT: [#8] json-parse-financial Cycles:10 Average:63.40 Median:63.00 stddev:2.07 (3.3%) stddev-sans-first:2.18 05:29:10 INFO - 2015-11-16 05:29:10,142 DEBUG : BROWSER_OUTPUT: Values: 64.0 63.0 63.0 63.0 63.0 62.0 63.0 69.0 62.0 62.0 05:29:10 INFO - 2015-11-16 05:29:10,142 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-16 05:29:10,142 DEBUG : BROWSER_OUTPUT: [#9] json-stringify-tinderbox Cycles:10 Average:71.50 Median:72.00 stddev:0.97 (1.3%) stddev-sans-first:0.87 05:29:10 INFO - 2015-11-16 05:29:10,142 DEBUG : BROWSER_OUTPUT: Values: 70.0 72.0 71.0 72.0 70.0 72.0 71.0 73.0 72.0 72.0 05:29:10 INFO - 2015-11-16 05:29:10,143 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-16 05:29:10,143 DEBUG : BROWSER_OUTPUT: [#10] stanford-crypto-aes Cycles:10 Average:87.30 Median:87.50 stddev:2.41 (2.7%) stddev-sans-first:2.55 05:29:10 INFO - 2015-11-16 05:29:10,143 DEBUG : BROWSER_OUTPUT: Values: 87.0 88.0 85.0 86.0 86.0 89.0 85.0 86.0 93.0 88.0 05:29:10 INFO - 2015-11-16 05:29:10,143 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-16 05:29:10,143 DEBUG : BROWSER_OUTPUT: [#11] stanford-crypto-ccm Cycles:10 Average:134.70 Median:135.50 stddev:5.25 (3.9%) stddev-sans-first:5.56 05:29:10 INFO - 2015-11-16 05:29:10,143 DEBUG : BROWSER_OUTPUT: Values: 134.0 134.0 136.0 122.0 135.0 135.0 132.0 139.0 141.0 139.0 05:29:10 INFO - 2015-11-16 05:29:10,143 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-16 05:29:10,143 DEBUG : BROWSER_OUTPUT: [#12] stanford-crypto-pbkdf2 Cycles:10 Average:158.30 Median:159.50 stddev:3.53 (2.2%) stddev-sans-first:3.54 05:29:10 INFO - 2015-11-16 05:29:10,143 DEBUG : BROWSER_OUTPUT: Values: 155.0 154.0 156.0 160.0 154.0 159.0 159.0 160.0 161.0 165.0 05:29:10 INFO - 2015-11-16 05:29:10,143 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-16 05:29:10,143 DEBUG : BROWSER_OUTPUT: [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.30 Median:71.00 stddev:0.82 (1.2%) stddev-sans-first:0.87 05:29:10 INFO - 2015-11-16 05:29:10,143 DEBUG : BROWSER_OUTPUT: Values: 71.0 71.0 71.0 71.0 71.0 70.0 72.0 71.0 73.0 72.0 05:29:10 INFO - 2015-11-16 05:29:10,143 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:29:10 INFO - 2015-11-16 05:29:10,143 DEBUG : BROWSER_OUTPUT: 05:29:10 INFO - 2015-11-16 05:29:10,797 INFO : Browser exited with error code: 0 05:29:10 INFO - 2015-11-16 05:29:10,845 INFO : Completed test kraken (00:00:58) 05:29:10 INFO - 2015-11-16 05:29:10,845 INFO : Starting test v8_7 05:29:10 INFO - 2015-11-16 05:29:10,845 DEBUG : operating with platform_type : mac_ 05:29:10 INFO - 2015-11-16 05:29:10,845 INFO : Initialising browser for v8_7 test... 05:29:10 INFO - 2015-11-16 05:29:10,857 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmpsCwwd7/profile http://localhost:49274/getInfo.html 05:29:13 INFO - 2015-11-16 05:29:13,742 DEBUG : BROWSER_OUTPUT: __metrics Screen width/height:1600/1200 05:29:13 INFO - 2015-11-16 05:29:13,743 DEBUG : BROWSER_OUTPUT: colorDepth:24 05:29:13 INFO - 2015-11-16 05:29:13,743 DEBUG : BROWSER_OUTPUT: Browser inner width/height: 1024/663 05:29:13 INFO - 2015-11-16 05:29:13,743 DEBUG : BROWSER_OUTPUT: __metrics 05:29:14 INFO - 2015-11-16 05:29:14,370 INFO : Browser initialized. 05:29:14 INFO - 2015-11-16 05:29:14,371 INFO : Running cycle 1/1 for v8_7 test... 05:29:14 INFO - 2015-11-16 05:29:14,371 DEBUG : command line: /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/tmpsCwwd7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/v8_7/v8.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1 05:29:26 INFO - 2015-11-16 05:29:26,358 DEBUG : BROWSER_OUTPUT: RSS: Main: 240574464 05:29:26 INFO - 2015-11-16 05:29:26,358 DEBUG : BROWSER_OUTPUT: 05:29:47 INFO - 2015-11-16 05:29:47,779 DEBUG : BROWSER_OUTPUT: Cycle 1(1): loaded http://localhost:49274/tests/v8_7/run.html (next: http://localhost:49274/tests/v8_7/run.html) 05:29:48 INFO - 2015-11-16 05:29:48,038 DEBUG : BROWSER_OUTPUT: RSS: Main: 260820992 05:29:48 INFO - 2015-11-16 05:29:48,038 DEBUG : BROWSER_OUTPUT: 05:29:48 INFO - 2015-11-16 05:29:48,038 DEBUG : BROWSER_OUTPUT: __start_tp_report 05:29:48 INFO - 2015-11-16 05:29:48,039 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load 05:29:48 INFO - 2015-11-16 05:29:48,039 DEBUG : BROWSER_OUTPUT: _x_x_mozilla_page_load_details 05:29:48 INFO - 2015-11-16 05:29:48,039 DEBUG : BROWSER_OUTPUT: |i|pagename|runs| 05:29:48 INFO - 2015-11-16 05:29:48,039 DEBUG : BROWSER_OUTPUT: |0;Richards;166.77785190126752 05:29:48 INFO - 2015-11-16 05:29:48,039 DEBUG : BROWSER_OUTPUT: |1;DeltaBlue;190.80328181644725 05:29:48 INFO - 2015-11-16 05:29:48,039 DEBUG : BROWSER_OUTPUT: |2;Encrypt;332.00531208499336 05:29:48 INFO - 2015-11-16 05:29:48,039 DEBUG : BROWSER_OUTPUT: |3;Decrypt;5819.767441860465 05:29:48 INFO - 2015-11-16 05:29:48,039 DEBUG : BROWSER_OUTPUT: |4;RayTrace;1120.9406494960806 05:29:48 INFO - 2015-11-16 05:29:48,040 DEBUG : BROWSER_OUTPUT: |5;Earley;815.6606851549756 05:29:48 INFO - 2015-11-16 05:29:48,040 DEBUG : BROWSER_OUTPUT: |6;Boyer;13888.888888888889 05:29:48 INFO - 2015-11-16 05:29:48,040 DEBUG : BROWSER_OUTPUT: |7;RegExp;29371.428571428572 05:29:48 INFO - 2015-11-16 05:29:48,040 DEBUG : BROWSER_OUTPUT: |8;Splay;655.7377049180328 05:29:48 INFO - 2015-11-16 05:29:48,040 DEBUG : BROWSER_OUTPUT: |9;NavierStokes;5803.468208092486 05:29:48 INFO - 2015-11-16 05:29:48,040 DEBUG : BROWSER_OUTPUT: __end_tp_report 05:29:48 INFO - 2015-11-16 05:29:48,040 DEBUG : BROWSER_OUTPUT: __startTimestamp1447680588032__endTimestamp 05:29:48 INFO - 2015-11-16 05:29:48,040 DEBUG : BROWSER_OUTPUT: 05:29:48 INFO - 2015-11-16 05:29:48,041 DEBUG : BROWSER_OUTPUT: ------- Summary: start ------- 05:29:48 INFO - 2015-11-16 05:29:48,041 DEBUG : BROWSER_OUTPUT: Number of tests: 10 05:29:48 INFO - 2015-11-16 05:29:48,041 DEBUG : BROWSER_OUTPUT: 05:29:48 INFO - 2015-11-16 05:29:48,041 DEBUG : BROWSER_OUTPUT: [#0] Richards Cycles:1 Average:166.78 Median:166.78 stddev:0.00 (0.0%) 05:29:48 INFO - 2015-11-16 05:29:48,041 DEBUG : BROWSER_OUTPUT: Values: 166.8 05:29:48 INFO - 2015-11-16 05:29:48,041 DEBUG : BROWSER_OUTPUT: 05:29:48 INFO - 2015-11-16 05:29:48,041 DEBUG : BROWSER_OUTPUT: [#1] DeltaBlue Cycles:1 Average:190.80 Median:190.80 stddev:0.00 (0.0%) 05:29:48 INFO - 2015-11-16 05:29:48,041 DEBUG : BROWSER_OUTPUT: Values: 190.8 05:29:48 INFO - 2015-11-16 05:29:48,041 DEBUG : BROWSER_OUTPUT: 05:29:48 INFO - 2015-11-16 05:29:48,041 DEBUG : BROWSER_OUTPUT: [#2] Encrypt Cycles:1 Average:332.01 Median:332.01 stddev:0.00 (0.0%) 05:29:48 INFO - 2015-11-16 05:29:48,041 DEBUG : BROWSER_OUTPUT: Values: 332.0 05:29:48 INFO - 2015-11-16 05:29:48,042 DEBUG : BROWSER_OUTPUT: 05:29:48 INFO - 2015-11-16 05:29:48,042 DEBUG : BROWSER_OUTPUT: [#3] Decrypt Cycles:1 Average:5819.77 Median:5819.77 stddev:0.00 (0.0%) 05:29:48 INFO - 2015-11-16 05:29:48,042 DEBUG : BROWSER_OUTPUT: Values: 5819.8 05:29:48 INFO - 2015-11-16 05:29:48,042 DEBUG : BROWSER_OUTPUT: 05:29:48 INFO - 2015-11-16 05:29:48,042 DEBUG : BROWSER_OUTPUT: [#4] RayTrace Cycles:1 Average:1120.94 Median:1120.94 stddev:0.00 (0.0%) 05:29:48 INFO - 2015-11-16 05:29:48,042 DEBUG : BROWSER_OUTPUT: Values: 1120.9 05:29:48 INFO - 2015-11-16 05:29:48,042 DEBUG : BROWSER_OUTPUT: 05:29:48 INFO - 2015-11-16 05:29:48,042 DEBUG : BROWSER_OUTPUT: [#5] Earley Cycles:1 Average:815.66 Median:815.66 stddev:0.00 (0.0%) 05:29:48 INFO - 2015-11-16 05:29:48,042 DEBUG : BROWSER_OUTPUT: Values: 815.7 05:29:48 INFO - 2015-11-16 05:29:48,042 DEBUG : BROWSER_OUTPUT: 05:29:48 INFO - 2015-11-16 05:29:48,042 DEBUG : BROWSER_OUTPUT: [#6] Boyer Cycles:1 Average:13888.89 Median:13888.89 stddev:0.00 (0.0%) 05:29:48 INFO - 2015-11-16 05:29:48,042 DEBUG : BROWSER_OUTPUT: Values: 13888.9 05:29:48 INFO - 2015-11-16 05:29:48,042 DEBUG : BROWSER_OUTPUT: 05:29:48 INFO - 2015-11-16 05:29:48,042 DEBUG : BROWSER_OUTPUT: [#7] RegExp Cycles:1 Average:29371.43 Median:29371.43 stddev:0.00 (0.0%) 05:29:48 INFO - 2015-11-16 05:29:48,042 DEBUG : BROWSER_OUTPUT: Values: 29371.4 05:29:48 INFO - 2015-11-16 05:29:48,043 DEBUG : BROWSER_OUTPUT: 05:29:48 INFO - 2015-11-16 05:29:48,043 DEBUG : BROWSER_OUTPUT: [#8] Splay Cycles:1 Average:655.74 Median:655.74 stddev:0.00 (0.0%) 05:29:48 INFO - 2015-11-16 05:29:48,043 DEBUG : BROWSER_OUTPUT: Values: 655.7 05:29:48 INFO - 2015-11-16 05:29:48,043 DEBUG : BROWSER_OUTPUT: 05:29:48 INFO - 2015-11-16 05:29:48,043 DEBUG : BROWSER_OUTPUT: [#9] NavierStokes Cycles:1 Average:5803.47 Median:5803.47 stddev:0.00 (0.0%) 05:29:48 INFO - 2015-11-16 05:29:48,043 DEBUG : BROWSER_OUTPUT: Values: 5803.5 05:29:48 INFO - 2015-11-16 05:29:48,043 DEBUG : BROWSER_OUTPUT: -------- Summary: end -------- 05:29:48 INFO - 2015-11-16 05:29:48,043 DEBUG : BROWSER_OUTPUT: 05:29:48 INFO - 2015-11-16 05:29:48,675 INFO : Browser exited with error code: 0 05:29:48 INFO - 2015-11-16 05:29:48,695 INFO : Completed test v8_7 (00:00:37) 05:29:49 INFO - 2015-11-16 05:29:49,171 INFO : Completed test suite (00:20:09) 05:29:49 INFO - 2015-11-16 05:29:49,171 DEBUG : Working with test: dromaeo_css 05:29:49 INFO - 2015-11-16 05:29:49,171 DEBUG : Generating results file: dromaeo_css 05:29:49 INFO - 2015-11-16 05:29:49,172 DEBUG : Working with test: kraken 05:29:49 INFO - 2015-11-16 05:29:49,172 DEBUG : Generating results file: kraken 05:29:49 INFO - 2015-11-16 05:29:49,172 INFO : javascript benchmark 05:29:49 INFO - 2015-11-16 05:29:49,172 DEBUG : Working with test: v8_7 05:29:49 INFO - 2015-11-16 05:29:49,172 DEBUG : Generating results file: v8_7 05:29:49 INFO - 2015-11-16 05:29:49,172 INFO : Posting result 0 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:29:49 INFO - 2015-11-16 05:29:49,221 DEBUG : process_Request line: dromaeo_css graph.html#tests=[[72,1,57]] 05:29:49 INFO - 2015-11-16 05:29:49,221 DEBUG : process_Request line: dromaeo_css 6617.12 graph.html#tests=[[72,1,57]] 05:29:49 INFO - 2015-11-16 05:29:49,221 INFO : Posting result 1 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:29:49 INFO - 2015-11-16 05:29:49,245 DEBUG : process_Request line: kraken 1538.50 graph.html#tests=[[232,1,57]] 05:29:49 INFO - 2015-11-16 05:29:49,245 INFO : Posting result 2 of 3 to http://graphs.mozilla.org/server/collect.cgi, attempt 0 05:29:49 INFO - 2015-11-16 05:29:49,270 DEBUG : process_Request line: v8_7 19303.34 graph.html#tests=[[230,1,57]] 05:29:49 INFO - 2015-11-16 05:29:49,271 INFO : javascript benchmark 05:29:49 INFO - 2015-11-16 05:29:49,273 INFO : TALOSDATA: [{"talos_counters": {}, "results": {"jquery.html": [319.8432767943708, 323.71027930002646, 324.08930904159314, 329.82253355520794, 336.04898138268703, 11390.316581005145, 11755.706107347321, 16519.339226430944, 17154.79916405852, 17412.738808917846, 11291.378974156418, 11301.604443844468, 11497.252678575887, 11505.309681419121, 11545.942270288637, 4189.392538081976, 4278.35824626307, 4291.613754762071, 4308.0, 4319.438472998521, 4135.813888375015, 4167.854125105622, 4197.223513649969, 4240.469941257343, 4245.617894389505, 4152.584741525839, 4178.143480586473, 4270.957290427103, 4458.175237581057, 4509.706869053517, 4322.546132656089, 4392.692511524195, 4448.466184057934, 4469.955300447003, 4487.349334346518, 3758.9812050939845, 3905.511811023622, 3906.0, 3911.4523966644692, 3919.7452165609143, 12483.875161248452, 12596.874031259662, 12696.74606507874, 21862.781372186233, 22816.65775013376, 2018.0616013553622, 2047.4369548374316, 2117.28012475759, 2130.893455327243, 2137.6152292587326, 13535.187888726708, 13706.109102908378, 14017.859821401757, 14073.225972571505, 14216.857831421657, 1664.3093116356697, 1669.0403018264547, 1740.7562941188244, 1765.3203516646056, 1801.702719051355, 62185.37814621841, 64131.35868641347, 64183.358166418206, 64545.35454645487, 64970.3502964969, 16314.0, 16507.0, 16604.169791510376, 16623.50129496117, 16690.082045487616, 24044.75955240425, 24094.0, 24145.517089658108, 24217.63673544898, 24267.514649706907, 8998.325125615605, 9111.863322050174, 9149.81700365989, 9193.770155746026, 9224.077592240856, 7624.199459056719, 7624.69501219945, 7626.771196864103, 7665.846683066307, 7689.50018248812, 7780.066392032879, 7925.445218834741, 7945.64244608994, 7958.562279074707, 7994.1606131355375, 3271.4765637498363, 3323.052929915011, 3347.866085356607, 3440.552728145325, 3458.5849698035895, 391.106322054105, 394.50686641697877, 399.4168513969637, 402.8549722100042, 414.95228048774777, 10438.478076096164, 10566.735831604117, 10610.20423468243, 10614.787704245871, 10682.252242342962, 389.5520151825367, 393.99606003939596, 406.92878746219293, 408.3507223514626, 418.50407267388243, 4265.4241677373775, 5661.801836935688, 5705.5720820938595, 5735.369109397963, 5788.913166302509, 390619.0, 400386.0, 544192.0, 551564.0, 619978.0, 64604.35395646077, 67815.3218467809, 67884.0, 68107.31892681109, 68711.3128868705, 409.5085896923644, 420.0967918974169, 423.7499875073721, 424.54997702435514, 426.2774597057957, 9499.287553433382, 9570.090841370336, 9642.614295428104, 9912.454814984956, 9958.601655933682, 33400.66599334073, 34285.31429371348, 34833.12917177091, 34929.825350873085, 35306.293874122886, 46016.0, 46564.06871862611, 46778.29832552446, 46920.29619555778, 46952.7652361736, 7381.667824947997, 7465.58939258346, 7570.507916985378, 7599.772006839804, 7622.199669034893, 11174.66476005721, 11249.831252531056, 11469.0, 11531.250468719507, 11535.423228838357, 9359.344845860724, 9697.321187516805, 9883.50582470888, 9900.603975841173, 9938.900610993798, 9519.524023798644, 9582.760430989003, 9615.5672994714, 9710.223182145553, 9728.17310528613, 9799.167070799062, 9921.305508614329, 10026.849597256192, 10046.0, 10180.083792458714, 7284.562926224444, 7409.444291678254, 7459.0, 7466.328030477283, 7577.128630207597, 9679.70960871175, 9707.66023189185, 9796.265280104164, 9975.501224938578, 10197.898021019695], "dojo.html": [3093.582366380538, 3155.179653290144, 3231.0629917323977, 3265.6897594728507, 3303.3888730584836, 4996.2006079027315, 5122.206058060997, 5131.9743401282985, 5146.897062058757, 5189.714565698894, 5001.799928002884, 5052.520010598996, 5066.847994560169, 5145.614078944085, 5187.092258854695, 4658.2313918203545, 4733.59764420023, 4788.832390866321, 4804.351412559295, 4833.661643684926, 139.80910262295995, 4790.952090479085, 4814.9759251203695, 4829.661923665345, 4853.3690620219495, 4764.499727528594, 4812.470628230892, 4814.903701925942, 4859.271109333628, 4878.829240976566, 4823.975880120612, 4830.2513110467935, 4855.465898751135, 4870.683405578661, 4928.088303663798, 4630.7453090080035, 4690.5778479936625, 4751.64362672801, 4848.9757551212015, 4883.169861123618, 4924.679895806797, 4957.107720610289, 5053.84838454847, 5175.637705360627, 5291.761870715827, 5475.808346707846, 5490.917636235459, 5493.642913210629, 5499.560035197174, 5520.1167813149705, 5386.757595908193, 5513.2005859150195, 5524.723763811793, 5679.460451257124, 5680.204771331975, 5163.302954101186, 5167.689938603696, 5177.0, 5179.792808287664, 5230.3985041719925, 5534.723263836872, 5709.314882214161, 5718.199452076629, 5737.340205876378, 5756.079027355603, 5330.9733451332495, 5364.356277246756, 5367.785288588413, 5394.568434525228, 5418.972905135528, 5418.593605479526, 5528.198411230349, 5552.0, 5557.638753481011, 5590.91613625796, 5209.166533354645, 5343.412224655285, 5444.91832622511, 5453.836384908459, 5518.641288316247, 5333.599980001515, 5388.649737767033, 5392.703401312887, 5398.082326004589, 5413.052715774724, 4232.111256636079, 4246.278132717383, 4275.850345237902, 4290.528041915387, 4321.438213032348, 3778.981105094457, 3782.8486860525272, 3894.4937158169255, 3918.5101862267215, 3925.980370098131, 5216.4522725114075, 5247.55395791362, 5250.343707036621, 5264.368275806851, 5305.734713264322, 5586.301712285965, 5592.021396255639, 5620.690862002547, 5651.0, 5724.656520608777, 4977.1538838397555, 5078.847634570969, 5117.437081920985, 5196.714180720021, 5261.3686357637325, 4906.435759887588, 4908.337374454474, 4969.229769385751, 4969.552740253394, 5057.064443078042, 5787.768489260382, 5811.244538210006, 5828.475437210672, 5842.737076831638, 5866.853328666817, 5375.892482150257, 5536.7231638417115, 5568.053430916835, 5602.635828671123, 5746.3966283541295, 5780.884382312246, 5824.679642619697, 5827.854303642273, 5840.766369345349, 5878.706064696663, 5417.918731219113, 5504.559635229252, 5560.582956278215, 5562.360328562268, 5570.3315602128005, 5509.807156749494, 5555.388907220122, 5626.156076588544, 5642.5485961122195, 5680.488756011979, 5475.4524547544925, 5483.8080667176455, 5484.643498172606, 5507.476789704971, 5514.365847927379, 5271.077561426659, 5364.731763411735, 5400.567954563704, 5510.311211098613, 5529.778808847601, 5301.946980530145, 5312.7343632818975, 5361.088614935392, 5403.7838486460105, 5440.075187218104, 5347.973260133675, 5526.115821468546, 5534.861628459321, 5537.197106419466, 5539.058360078716, 5236.0, 5270.262163297065, 5342.252084708066, 5441.945580544302, 5444.673319600836], "mootools.html": [1411.4072089722315, 1728.2741248675563, 1761.11944027986, 1786.0355408079638, 1798.667246559387, 6842.0, 6966.477514186431, 7363.742269020585, 7508.812279693004, 7536.736214232503, 7391.593462359581, 7639.236076392358, 7699.499532530382, 7743.457957942946, 7792.103908050576, 2150.9892450537727, 2197.3517812245345, 2202.2952655150357, 2203.9338819835352, 2216.024949022425, 2230.509287956647, 2279.555486680098, 2280.874551899653, 2292.8280378971563, 2308.7691230876944, 2198.9670154947607, 2205.3604454708116, 2206.30501392061, 2227.131418746682, 2242.663600459936, 2199.82401407887, 2247.6179049561533, 2250.5723912456665, 2256.909723611062, 2276.7950884420484, 2261.97738022621, 2278.191242109044, 2280.441291883483, 2287.7712228777154, 2291.9770802291932, 7623.161452240249, 7675.078990521173, 7713.267239612228, 7732.845343093107, 7831.099423566249, 4610.147122782262, 4754.381930349067, 4769.117713223065, 4792.664513484023, 4794.688345257547, 2913.0823790506133, 3017.9889736938153, 3020.5167173252175, 3022.4106299271652, 3024.6672865984724, 863.1842908451453, 871.2594294849391, 879.50747581354, 892.2371372476568, 931.8369285375032, 9960.850587241197, 9990.20078393734, 10063.647772328006, 10156.796864062677, 10208.89791102087, 4285.0, 4302.0, 4376.387305777193, 4413.933790993137, 4445.5109937907455, 8295.751127466187, 8327.750167494985, 8395.160483951679, 8400.075991640915, 8403.327733781283, 4854.393200849894, 4890.462049174588, 4923.950760492421, 4951.9752401237765, 4956.876078098005, 4018.216447792652, 4053.452783874139, 4285.250081235771, 4527.773611319487, 4538.909221815546, 3399.099238701746, 3445.707114895212, 3498.7026102781037, 3509.0, 3538.363094642989, 1090.4275255490772, 1100.4002818463796, 1103.0183137008069, 1111.4776055254017, 1125.1842414249768, 965.5751469353462, 981.5386768218925, 995.144176008632, 1100.2353364411656, 1310.960671179866, 7251.854962900818, 7277.89083163753, 7288.380487658503, 7351.522151060164, 7370.005049318273, 1169.7017260598493, 1208.4924331780674, 1223.525651589832, 1227.7728620205291, 1238.9132760706843, 5675.3757086720425, 5685.317761868602, 5717.8570535736935, 5737.799177028784, 5864.149698293723, 9240.537973101318, 9294.767630809283, 9344.205742511827, 9345.906540934504, 9459.10138536838, 9216.953915230515, 9231.815363692689, 9234.030426805222, 9236.630534778667, 9291.72124836256, 7125.287471252833, 7155.177154627285, 7251.564906105545, 7268.219286274896, 7324.0, 7069.505134640526, 7184.209736928829, 7287.1984081752025, 7303.817404564716, 7309.707611695472, 8035.236652518001, 8231.794205144679, 8255.298299644357, 8256.25693687571, 8314.376421768271, 8447.91552084496, 8503.0221524523, 8541.188587084218, 8544.316454683487, 8588.613512391832, 6536.738530458729, 6572.638504882086, 6635.469162467088, 6796.286389929184, 6830.487713421613, 7221.241769614115, 7253.891191632024, 7268.127824661075, 7397.926020739724, 7400.888986665097, 6786.660666966731, 6851.07510486078, 6897.068895699016, 6935.618540980295, 7061.823454413475, 6793.864122717419, 6848.452123829982, 6858.074159988338, 6862.039314496074, 6967.268436814062, 6440.388163124496, 6857.897131542931, 6940.479464040318, 7020.5787652741, 7027.789166325018, 6385.521085918667, 6417.101605775102, 6425.935740642721, 6428.710708018057, 6434.742610295536, 6490.675466226576, 6513.73945042193, 6551.639659818756, 6566.80299591013, 6608.074869518176], "ext.html": [549.8762778374869, 551.4513059505791, 551.5752870289876, 563.7153237615004, 568.4372471253457, 38192.0, 39096.609033909655, 39184.80407597961, 39238.0, 39494.80252598733, 42112.36831447531, 42277.36583951236, 42351.57648423515, 42381.36427953583, 42476.08857601407, 8848.2478989286, 9011.05383934684, 9036.728898133066, 9073.0, 9080.545972701339, 8863.734087977371, 8958.686445974392, 9015.909840901573, 9016.729498115033, 9118.270538356915, 8801.383903126753, 8905.910940890573, 8912.509811960339, 8917.509536975464, 8928.151825576593, 8974.730758077269, 9005.594748236344, 9048.366614337, 9058.0, 9179.403338782959, 8774.517401542913, 8788.077251888588, 8873.11268873114, 8930.151635594608, 8976.820463590691, 38146.80926595377, 38824.61175388238, 38833.61166388328, 38895.41656875149, 38956.415653765216, 2393.664886915833, 2699.91435022971, 2984.9403011939858, 2992.6408830940427, 3552.2540266544056, 25724.48551028969, 26191.869040654867, 26580.73419265802, 26806.329841753915, 26860.731392686215, 2296.1413040764187, 2307.90768369265, 2320.6286994081033, 2331.9067237310487, 2402.231285988484, 240641.0, 244144.0, 244978.0, 245301.0, 246806.0, 43026.569734302255, 43636.56363436388, 43722.56277437248, 43729.56270437319, 56181.157282640794, 42343.0, 42515.36226956598, 42619.57380426218, 42890.78554607269, 43187.13625727468, 13431.731365372638, 13682.384292706853, 13694.246816424993, 13714.24571648569, 13793.172409655454, 10625.9468702656, 10663.253572250023, 10677.733056673645, 10783.08343790771, 10816.351018938889, 13794.586162415144, 13818.309084545732, 13843.30783460823, 13893.374798134108, 13957.092788968888, 6077.878442431215, 6226.813195604139, 6276.121343011982, 6311.274203466568, 6337.686744338375, 895.1048951048951, 947.8862536495527, 1007.8135544924066, 1048.3971716263027, 1075.6504136155781, 27431.314217144332, 27952.72047279542, 27977.860110699723, 28152.85923570369, 28166.85916570445, 972.6206779356057, 994.3884511025667, 997.3467378866853, 1034.2605037398296, 1137.8407023016784, 14517.128972261698, 14573.0, 14670.413183472541, 14698.265086745834, 15015.774763378558, 287168.0, 298821.0, 301001.0, 301708.0, 308887.0, 52608.0, 53087.0, 53372.46627533675, 53441.198382024304, 53536.732316338166, 1311.5344052861287, 1312.173330801589, 1318.808772727949, 1326.3434599873124, 1334.8865346445662, 27114.1865744028, 27214.746986024846, 27650.585241220997, 27761.44477110406, 27967.44065118727, 46236.30645540387, 46612.0, 46699.0, 46755.99999999864, 46904.765476173765, 259964.0, 260797.0, 261294.0, 261500.0, 261688.0, 31487.21281967969, 42979.570204298805, 44464.777676111415, 44508.77745611251, 44746.55253447424, 42363.0, 42801.0, 43037.0, 43265.35101973536, 43551.78224108859, 34696.653033469345, 35503.0, 35715.28569428545, 35936.82031589825, 36552.0, 34142.0, 34208.31583368269, 34709.65290347064, 34737.47893781646, 34806.47790283198, 35709.82145089258, 35971.640283596826, 36069.819650901576, 36076.81961590175, 36630.26739465249, 30462.695373045986, 30710.539341909443, 30753.231169220948, 30936.53595196029, 30995.380092397576, 23415.76584234136, 23769.762302377447, 24009.279721608378, 24061.0, 24192.395190120387], "prototype.html": [311.9532070189471, 313.4498954335142, 314.71361061434095, 317.91416317594235, 321.0432909928412, 6168.167297414848, 6248.437640612344, 6257.593256438334, 6314.652694101828, 6370.267419246788, 6076.301225359085, 6197.628142311453, 6258.62448253104, 6306.7161977711, 6310.305866354709, 4723.763811809413, 4758.571728544431, 4775.80896764129, 4780.16347139251, 4829.1790395632825, 4737.620990320784, 4745.311929770181, 4769.642276829234, 4778.904421911559, 4794.352762377087, 4563.680542362036, 4704.882377940545, 4709.340692303081, 4712.5758681718635, 4735.976320118394, 4691.319758635013, 4699.0836786826585, 4710.199266124733, 4731.810727570893, 4747.287906813971, 3853.691704663648, 3955.208958208341, 4066.898327541835, 4071.4096456013713, 4081.8367265309353, 6039.124326972608, 6039.818805435844, 6078.939210607881, 6079.848003799896, 6085.421884920926, 5246.396664383607, 5251.2123181523075, 5262.631615786897, 5307.28351672527, 5314.149736042254, 6477.773277935296, 6479.1901012373455, 6494.155759751249, 6548.93451065488, 6556.0, 4171.457710497616, 4311.28863737483, 4313.072689371768, 4320.330348795942, 4328.978355108205, 6814.0, 6901.413379862718, 6939.167299923991, 6949.652517374111, 6958.79123626292, 4368.7815609219415, 4380.9780951095045, 4391.494978077562, 4393.824247030147, 4460.041091165415, 4318.827246910151, 4460.955390446054, 4461.732296062247, 4488.573585509372, 4488.775561221991, 5231.738413079407, 5244.895102097937, 5254.710990895461, 5266.131088370376, 5285.577153827761, 6538.8365290868105, 6544.411003009752, 6546.738130474728, 6561.737530498822, 6623.602583844889, 1532.5478983699836, 1580.7154712151694, 1580.786593809844, 1580.8023997000375, 1583.7228485015075, 996.3274789517047, 1007.808516381885, 1013.2856336282903, 1023.9334443261164, 1030.0832259289239, 6291.842703932438, 6296.118543403927, 6305.0, 6318.115463835067, 6333.113364129025, 6812.046313516112, 6814.863702725917, 6814.965925170342, 6870.931290687029, 6894.13823272091, 6117.296510901214, 6267.0, 6302.527310451735, 6316.178896743486, 6360.109584658059, 3659.7255205859665, 3696.4085746281003, 3704.0554658562432, 3707.796071216109, 3739.2521495700967, 7004.194517630538, 7154.678039488235, 7155.785326440215, 7228.38558722504, 7253.709851605877, 7086.468514861406, 7116.679749411289, 7175.425965922714, 7182.0, 7185.101862267216, 7031.613261270679, 7134.750283740044, 7185.461090418239, 7207.96396018027, 7213.675384607705, 6909.654517274217, 6916.896246556406, 6929.341712537301, 6968.059311993019, 6990.161180658353, 6760.391564759196, 6772.0857684212, 6792.898106528307, 6801.965990170018, 6819.556728812611, 6884.621345825827, 7112.715491380493, 7134.643267836484, 7168.928310716826, 7195.568265904062, 4359.738415695068, 4364.803583838671, 4391.451068616423, 4395.670324725722, 4428.490723566831, 6828.351306625863, 6834.658267086726, 6842.692078856364, 6889.104416425833, 6891.620960847202, 6370.968145159244, 6511.967440162769, 6582.045603387578, 6617.742628900493, 6653.268140504444, 6650.935850263934, 6659.766908158192, 6664.300248474035, 6676.6995485202315, 6712.765053223114, 6487.578307410004, 6512.804615861532, 6520.673966301571, 6526.706298216686, 6530.987696906987, 6426.325235850169, 6667.299933506912, 6683.799486015428, 6705.865882682417, 6735.966320168368, 6418.19772528434, 6432.35676432353, 6456.451201647725, 6515.381038801306, 6528.967355163194], "yui.html": [733.8715724748171, 739.8520295940813, 750.8460765543063, 760.623491371771, 793.4817603209586, 11450.656480305594, 11793.941030294836, 11862.288262704244, 11883.64349069527, 12033.819492707595, 12370.443330050146, 12446.626601201955, 12495.31275779834, 12507.687307817308, 12555.0, 690.3441730356157, 691.8028361916855, 857.2927334948661, 878.9912100879005, 885.9855465492008, 847.7160151349306, 855.6791203298762, 866.2160744526213, 870.4907629037021, 878.3851304087133, 904.4708845325459, 915.7344370132654, 917.4632839788699, 918.3112665500875, 918.8070505193917, 903.9457632542036, 911.1344222988188, 911.3711539038043, 913.9040400757924, 917.206616276919, 658.1444122640548, 672.3310306245318, 674.7739507265023, 678.5352033856824, 681.3391010719594, 13183.406746696422, 13301.201927884262, 13409.798853017213, 13452.663683407894, 13487.932560337234, 11234.21360504765, 11311.925367090113, 11573.942130289379, 11619.825702614384, 11678.0, 7921.762347129596, 8033.357331413473, 8188.385871059694, 8213.507189568645, 8426.662933482654, 3187.2031992002, 3230.337780754963, 3231.062991732395, 3245.2049247934406, 3271.8200498972546, 47525.0, 47681.523184768055, 48159.0, 48876.266855997186, 49145.50854491409, 8751.168638979287, 8805.207531322212, 8834.602442890086, 8884.777880553038, 9094.454332740057, 18641.81358186428, 18755.812441875405, 18756.437306880816, 18796.436106916815, 18931.0, 6680.699368528428, 6681.198256209286, 6709.329067093349, 6806.55757375769, 6887.5178737487895, 3731.738778285494, 3772.679322257639, 3793.089658482, 3807.923841523154, 3831.63599458051, 2865.9713402866123, 2911.0539074800777, 2921.3865088331263, 2932.105707759154, 2938.9706102939126, 406.29305009284224, 407.2587890040158, 410.3524349735813, 413.6112054668602, 414.672408797053, 490.33314692018826, 523.3562717857058, 542.2544001997254, 566.7279705741267, 574.778710196569, 7729.304362607392, 8123.634436450374, 8197.672093116209, 8223.54770487629, 8308.70919517814, 442.36299728391015, 470.77402846633805, 532.653775046223, 545.2203349210666, 613.739160856643, 3239.368323177005, 3708.554973403209, 3846.615338466187, 3937.9803100984313, 3949.19041596472, 51155.209567664955, 51580.74209628928, 51652.0, 51759.48240517622, 51812.22281665778, 47167.0, 47895.521044789806, 48139.75930120397, 48520.0, 48683.26975095376, 44756.55243447589, 44845.0, 45068.54931450643, 45127.77436112799, 45679.543204568196, 7944.6822127114265, 7973.920260797549, 7981.960090199512, 8016.559089250147, 8271.710490132817, 33804.32391352209, 34339.14152146116, 35054.12364690801, 35061.649383505835, 35076.82461587676, 44115.77942110269, 44748.0, 45616.31575526304, 45765.31352029656, 45856.08287834292, 6911.5853048817235, 7095.3968912643, 7138.179109402485, 7181.461390395846, 7297.781066568012, 10684.83972740394, 10710.250282480152, 10875.456227188452, 11208.49561769706, 11261.042811360798, 9985.850212246967, 10143.695689129338, 10198.643047493302, 10860.131189504662, 10940.45297735126, 9320.440773553608, 9379.155875971195, 9543.42739435636, 9629.614815407305, 9906.851397228904, 8983.460992340219, 9052.411593246417, 10400.11599014062, 10434.843477347998, 10497.475126243504, 8716.912830871865, 8734.301255899385, 8815.294776417742, 8951.28389728807, 9444.008379120094, 8290.419670622998, 8303.709370172015, 8620.0, 9132.360734748503, 9165.816683666422]}, "summary": {"lowerIsBetter": false, "suite": 6617.122473040411, "subtests": {"jquery.html": {"lowerIsBetter": false, "filtered": 7526.004051454502, "unit": "ms", "value": 7526.004051454502}, "dojo.html": {"lowerIsBetter": false, "filtered": 5106.334152439515, "unit": "ms", "value": 5106.334152439515}, "mootools.html": {"lowerIsBetter": false, "filtered": 4424.503930423244, "unit": "ms", "value": 4424.503930423244}, "ext.html": {"lowerIsBetter": false, "filtered": 17329.15364372269, "unit": "ms", "value": 17329.15364372269}, "prototype.html": {"lowerIsBetter": false, "filtered": 4908.514569697034, "unit": "ms", "value": 4908.514569697034}, "yui.html": {"lowerIsBetter": false, "filtered": 5803.818954852564, "unit": "ms", "value": 5803.818954852564}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0016.e"}, "testrun": {"date": 1447679380, "suite": "dromaeo_css", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116030208", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}, {"talos_counters": {}, "results": {"audio-dft": [164.0, 165.0, 165.0, 166.0, 168.0, 168.0, 170.0, 172.0, 169.0, 167.0], "ai-astar": [108.0, 99.0, 108.0, 108.0, 107.0, 120.0, 109.0, 108.0, 108.0, 108.0], "imaging-gaussian-blur": [121.0, 117.0, 115.0, 115.0, 120.0, 117.0, 117.0, 126.0, 125.0, 129.0], "audio-beat-detection": [156.0, 130.0, 152.0, 159.0, 131.0, 151.0, 148.0, 129.0, 162.0, 128.0], "json-stringify-tinderbox": [70.0, 72.0, 71.0, 72.0, 70.0, 72.0, 71.0, 73.0, 72.0, 72.0], "stanford-crypto-pbkdf2": [155.0, 154.0, 156.0, 160.0, 154.0, 159.0, 159.0, 160.0, 161.0, 165.0], "json-parse-financial": [64.0, 63.0, 63.0, 63.0, 63.0, 62.0, 63.0, 69.0, 62.0, 62.0], "stanford-crypto-sha256-iterative": [71.0, 71.0, 71.0, 71.0, 71.0, 70.0, 72.0, 71.0, 73.0, 72.0], "audio-fft": [75.0, 74.0, 76.0, 66.0, 75.0, 70.0, 70.0, 119.0, 66.0, 69.0], "imaging-darkroom": [127.0, 127.0, 128.0, 127.0, 131.0, 128.0, 131.0, 137.0, 135.0, 131.0], "stanford-crypto-ccm": [134.0, 134.0, 136.0, 122.0, 135.0, 135.0, 132.0, 139.0, 141.0, 139.0], "audio-oscillator": [90.0, 90.0, 127.0, 88.0, 90.0, 89.0, 124.0, 88.0, 90.0, 137.0], "stanford-crypto-aes": [87.0, 88.0, 85.0, 86.0, 86.0, 89.0, 85.0, 86.0, 93.0, 88.0], "imaging-desaturate": [96.0, 108.0, 98.0, 105.0, 98.0, 103.0, 104.0, 113.0, 112.0, 103.0]}, "summary": {"lowerIsBetter": true, "suite": 1538.5, "subtests": {"audio-fft": {"lowerIsBetter": true, "filtered": 76.0, "unit": "ms", "value": 76.0}, "stanford-crypto-pbkdf2": {"lowerIsBetter": true, "filtered": 158.3, "unit": "ms", "value": 158.3}, "audio-beat-detection": {"lowerIsBetter": true, "filtered": 144.6, "unit": "ms", "value": 144.6}, "stanford-crypto-ccm": {"lowerIsBetter": true, "filtered": 134.7, "unit": "ms", "value": 134.7}, "imaging-darkroom": {"lowerIsBetter": true, "filtered": 130.2, "unit": "ms", "value": 130.2}, "json-parse-financial": {"lowerIsBetter": true, "filtered": 63.4, "unit": "ms", "value": 63.4}, "audio-oscillator": {"lowerIsBetter": true, "filtered": 101.3, "unit": "ms", "value": 101.3}, "ai-astar": {"lowerIsBetter": true, "filtered": 108.3, "unit": "ms", "value": 108.3}, "audio-dft": {"lowerIsBetter": true, "filtered": 167.4, "unit": "ms", "value": 167.4}, "stanford-crypto-sha256-iterative": {"lowerIsBetter": true, "filtered": 71.3, "unit": "ms", "value": 71.3}, "json-stringify-tinderbox": {"lowerIsBetter": true, "filtered": 71.5, "unit": "ms", "value": 71.5}, "imaging-gaussian-blur": {"lowerIsBetter": true, "filtered": 120.2, "unit": "ms", "value": 120.2}, "stanford-crypto-aes": {"lowerIsBetter": true, "filtered": 87.3, "unit": "ms", "value": 87.3}, "imaging-desaturate": {"lowerIsBetter": true, "filtered": 104.0, "unit": "ms", "value": 104.0}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0016.e"}, "testrun": {"date": 1447679380, "suite": "kraken", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116030208", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}, {"talos_counters": {}, "results": {"DeltaBlue": [190.80328181644725], "Encrypt": [332.00531208499336], "NavierStokes": [5803.468208092486], "Decrypt": [5819.767441860465], "Splay": [655.7377049180328], "Richards": [166.77785190126752], "RegExp": [29371.428571428572], "Earley": [815.6606851549756], "Boyer": [13888.888888888889], "RayTrace": [1120.9406494960806]}, "summary": {"lowerIsBetter": false, "suite": 19303.335151163363, "subtests": {"DeltaBlue": {"lowerIsBetter": false, "filtered": 346.5244380000001, "unit": "score", "value": 346.5244380000001}, "Encrypt": {"lowerIsBetter": false, "filtered": 801.737172, "unit": "score", "value": 801.737172}, "NavierStokes": {"lowerIsBetter": false, "filtered": 255.70916334661337, "unit": "score", "value": 255.70916334661337}, "Decrypt": {"lowerIsBetter": false, "filtered": 45.73739460539458, "unit": "score", "value": 45.73739460539458}, "Splay": {"lowerIsBetter": false, "filtered": 124.27377499999997, "unit": "score", "value": 124.27377499999997}, "RegExp": {"lowerIsBetter": false, "filtered": 31.016026264591456, "unit": "score", "value": 31.016026264591456}, "Richards": {"lowerIsBetter": false, "filtered": 211.67079199999998, "unit": "score", "value": 211.67079199999998}, "Earley": {"lowerIsBetter": false, "filtered": 817.0836380000003, "unit": "score", "value": 817.0836380000003}, "Boyer": {"lowerIsBetter": false, "filtered": 47.98533599999999, "unit": "score", "value": 47.98533599999999}, "RayTrace": {"lowerIsBetter": false, "filtered": 660.1500269730271, "unit": "score", "value": 660.1500269730271}}}, "test_machine": {"platform": "x86_64", "osversion": "OS X 10.10.2.e", "os": "mac", "name": "t-yosemite-r5-0016.e"}, "testrun": {"date": 1447679380, "suite": "v8_7", "options": {"responsiveness": false, "tpmozafterpaint": false, "tpchrome": true, "tppagecycles": 1, "tpcycles": 1, "tprender": false, "shutdown": false, "cycles": 1, "rss": false}}, "test_build": {"name": "Firefox", "version": "45.0a1", "id": "20151116030208", "branch": "Firefox", "revision": "48d636f678b0e5162ab868dc9024a5ffe350460c"}}] 05:29:49 INFO - RETURN: dromaeo_css: 6617.12 05:29:49 INFO - RETURN: kraken: 1538.50 05:29:49 INFO - RETURN: v8_7: 19303.34 05:29:49 INFO - TinderboxPrint: TalosResult: {"graphserver": {"v8_7": {"url": "http://graphs.mozilla.org/graph.html#tests=[[230,1,57]]", "result": "19303.34"}, "kraken": {"url": "http://graphs.mozilla.org/graph.html#tests=[[232,1,57]]", "result": "1538.50"}, "dromaeo_css": {"url": "http://graphs.mozilla.org/graph.html#tests=[[72,1,57]]", "result": "6617.12"}}} 05:29:49 INFO - Return code: 0 05:29:49 INFO - # TBPL SUCCESS # 05:29:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:29:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:29:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:29:49 INFO - 2015-11-16 05:29:49.384 screenresolution[1669:11679] starting screenresolution argv=screenresolution get 05:29:49 INFO - 2015-11-16 05:29:49.387 screenresolution[1669:11679] Display 0: 1600x1200x32@60 05:29:49 INFO - 2015-11-16 05:29:49.393 screenresolution[1670:11681] starting screenresolution argv=screenresolution list 05:29:49 INFO - Available Modes on Display 0 05:29:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:29:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:29:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:29:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:29:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:29:49 INFO - Intel HD Graphics 3000: 05:29:49 INFO - Chipset Model: Intel HD Graphics 3000 05:29:49 INFO - Type: GPU 05:29:49 INFO - Bus: Built-In 05:29:49 INFO - VRAM (Total): 512 MB 05:29:49 INFO - VRAM (Dynamic, Max): 10 05:29:49 INFO - Vendor: Intel (0x8086) 05:29:49 INFO - Device ID: 0x0116 05:29:49 INFO - Revision ID: 0x0009 05:29:49 INFO - Displays: 05:29:49 INFO - Display: 05:29:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:29:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:29:49 INFO - Display Serial Number: 1600x1200 60 05:29:49 INFO - Main Display: Yes 05:29:49 INFO - Mirror: Off 05:29:49 INFO - Online: Yes 05:29:49 INFO - Rotation: Supported 05:29:49 INFO - Return code: 0 05:29:49 INFO - Running post-action listener: _resource_record_post_action 05:29:49 INFO - Running post-run listener: _resource_record_post_run 05:29:50 INFO - Total resource usage - Wall time: 1248s; CPU: 30.0%; Read bytes: 42800128; Write bytes: 695011328; Read time: 6480; Write time: 68370 05:29:50 INFO - install - Wall time: 38s; CPU: 30.0%; Read bytes: 334230016; Write bytes: 333395968; Read time: 32790; Write time: 3123 05:29:50 INFO - run-tests - Wall time: 1210s; CPU: 30.0%; Read bytes: 41890816; Write bytes: 351252480; Read time: 5868; Write time: 64735 05:29:50 INFO - Running post-run listener: _upload_blobber_files 05:29:50 INFO - Blob upload gear active. 05:29:50 INFO - There are no files to upload in the directory. Skipping the blob upload mechanism ... 05:29:50 INFO - Copying logs to upload dir... 05:29:50 INFO - mkdir: /builds/slave/test/build/upload/logs program finished with exit code 0 elapsedTime=1375.459169 ========= master_lag: 0.03 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 22 mins, 55 secs) (at 2015-11-16 05:29:50.789133) ========= ========= Started set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 05:29:50.792732) ========= 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.7hzUsvsY7o/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.nba8VR1VON/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False build_url:https://queue.taskcluster.net/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010329 build_url: 'https://queue.taskcluster.net/v1/task/4IloHxv1TByRAkivd4ujUw/artifacts/public/build/firefox-45.0a1.en-US.mac.dmg' ========= master_lag: 0.02 ========= ========= Finished set props: build_url (results: 0, elapsed: 0 secs) (at 2015-11-16 05:29:50.823845) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:29:50.824238) ========= 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.7hzUsvsY7o/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.nba8VR1VON/Listeners TMPDIR=/var/folders/gg/q6y1_2717rsgmjth6gwwvht800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0x0:0x0 using PTY: False program finished with exit code 0 elapsedTime=0.005314 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2015-11-16 05:29:50.874565) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 05:29:50.874950) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2015-11-16 05:29:50.875439) ========= ========= Total master_lag: 0.49 =========