builder: mozilla-beta_yosemite_r7_test-dromaeojs-e10s slave: t-yosemite-r7-0296 starttime: 1469617242.71 results: success (0) buildid: 20160726073802 builduid: 6c72781d2b374e1f98a541c9c018fb4c revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:42.706879) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:42.707724) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:42.708159) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:42.735202) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:42.735765) ========= 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.XbId30KpPS/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.8weUf5GyPt/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2016-07-27 04:00:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12141 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 46.9M=0s 2016-07-27 04:00:42 (46.9 MB/s) - 'archiver_client.py' saved [12141/12141] program finished with exit code 0 elapsedTime=0.147481 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:42.913029) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:42.913590) ========= rm -rf scripts properties in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['rm', '-rf', 'scripts', 'properties'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XbId30KpPS/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.8weUf5GyPt/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.020248 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:42.966263) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 04:00:42.966758) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 958cee08361af9ed370be06695973bcda3d3aa46 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev 958cee08361af9ed370be06695973bcda3d3aa46 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XbId30KpPS/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.8weUf5GyPt/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2016-07-27 04:00:43,053 truncating revision to first 12 chars 2016-07-27 04:00:43,053 Setting DEBUG logging. 2016-07-27 04:00:43,053 attempt 1/10 2016-07-27 04:00:43,053 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/958cee08361a?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2016-07-27 04:00:44,497 unpacking tar archive at: mozilla-beta-958cee08361a/testing/mozharness/ program finished with exit code 0 elapsedTime=1.700761 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2016-07-27 04:00:44.691982) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:44.692483) ========= script_repo_revision: 958cee08361af9ed370be06695973bcda3d3aa46 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:44.693071) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:44.693465) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2016-07-27 04:00:44.715594) ========= ========= Started '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-07-27 04:00:44.716127) ========= /tools/buildbot/bin/python scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.XbId30KpPS/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.8weUf5GyPt/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:00:44 INFO - MultiFileLogger online at 20160727 04:00:44 in /builds/slave/test 04:00:44 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs-e10s --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 04:00:44 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:00:44 INFO - {'append_to_log': False, 04:00:44 INFO - 'base_work_dir': '/builds/slave/test', 04:00:44 INFO - 'blob_upload_branch': 'Mozilla-Beta', 04:00:44 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:00:44 INFO - 'branch': 'Mozilla-Beta', 04:00:44 INFO - 'buildbot_json_path': 'buildprops.json', 04:00:44 INFO - 'config_files': ('talos/mac_config.py',), 04:00:44 INFO - 'default_actions': ('clobber', 04:00:44 INFO - 'read-buildbot-config', 04:00:44 INFO - 'download-and-extract', 04:00:44 INFO - 'populate-webroot', 04:00:44 INFO - 'create-virtualenv', 04:00:44 INFO - 'install', 04:00:44 INFO - 'run-tests'), 04:00:44 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:00:44 INFO - 'download_minidump_stackwalk': True, 04:00:44 INFO - 'download_symbols': 'ondemand', 04:00:44 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:00:44 INFO - 'tooltool.py': '/tools/tooltool.py', 04:00:44 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:00:44 INFO - '/tools/misc-python/virtualenv.py')}, 04:00:44 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:00:44 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:00:44 INFO - 'installer_path': 'installer.exe', 04:00:44 INFO - 'log_level': 'info', 04:00:44 INFO - 'log_name': 'talos', 04:00:44 INFO - 'log_to_console': True, 04:00:44 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:00:44 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:00:44 INFO - 'opt_config_files': (), 04:00:44 INFO - 'pip_index': False, 04:00:44 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:00:44 INFO - 'cmd': ('bash', 04:00:44 INFO - '-c', 04:00:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:00:44 INFO - 'enabled': True, 04:00:44 INFO - 'halt_on_failure': False, 04:00:44 INFO - 'name': 'check_screen_resolution'},), 04:00:44 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:00:44 INFO - 'cmd': ('bash', 04:00:44 INFO - '-c', 04:00:44 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:00:44 INFO - 'enabled': True, 04:00:44 INFO - 'halt_on_failure': False, 04:00:44 INFO - 'name': 'check_screen_resolution'},), 04:00:44 INFO - 'run_cmd_checks_enabled': True, 04:00:44 INFO - 'sps_profile': False, 04:00:44 INFO - 'sps_profile_interval': 0, 04:00:44 INFO - 'suite': 'dromaeojs-e10s', 04:00:44 INFO - 'system_bits': '32', 04:00:44 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:00:44 INFO - 'title': 't-yosemite-r7-0296', 04:00:44 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:00:44 INFO - 'use_talos_json': True, 04:00:44 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:00:44 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:00:44 INFO - 'work_dir': 'build'} 04:00:44 INFO - ##### 04:00:44 INFO - ##### Running clobber step. 04:00:44 INFO - ##### 04:00:44 INFO - Running pre-action listener: _resource_record_pre_action 04:00:44 INFO - Running main action method: clobber 04:00:44 INFO - rmtree: /builds/slave/test/build 04:00:44 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:00:46 INFO - Running post-action listener: _resource_record_post_action 04:00:46 INFO - ##### 04:00:46 INFO - ##### Running read-buildbot-config step. 04:00:46 INFO - ##### 04:00:46 INFO - Running pre-action listener: _resource_record_pre_action 04:00:46 INFO - Running main action method: read_buildbot_config 04:00:46 INFO - Using buildbot properties: 04:00:46 INFO - { 04:00:46 INFO - "project": "", 04:00:46 INFO - "product": "firefox", 04:00:46 INFO - "script_repo_revision": "production", 04:00:46 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs-e10s", 04:00:46 INFO - "repository": "", 04:00:46 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs-e10s", 04:00:46 INFO - "buildid": "20160726073802", 04:00:46 INFO - "pgo_build": "False", 04:00:46 INFO - "basedir": "/builds/slave/test", 04:00:46 INFO - "buildnumber": 67, 04:00:46 INFO - "slavename": "t-yosemite-r7-0296", 04:00:46 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 04:00:46 INFO - "platform": "yosemite_r7", 04:00:46 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 04:00:46 INFO - "branch": "mozilla-beta", 04:00:46 INFO - "repo_path": "releases/mozilla-beta", 04:00:46 INFO - "revision": "958cee08361af9ed370be06695973bcda3d3aa46", 04:00:46 INFO - "stage_platform": "macosx64", 04:00:46 INFO - "builduid": "6c72781d2b374e1f98a541c9c018fb4c", 04:00:46 INFO - "slavebuilddir": "test" 04:00:46 INFO - } 04:00:46 INFO - Found installer url https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg. 04:00:46 INFO - Running post-action listener: _resource_record_post_action 04:00:46 INFO - ##### 04:00:46 INFO - ##### Running download-and-extract step. 04:00:46 INFO - ##### 04:00:46 INFO - Running pre-action listener: _resource_record_pre_action 04:00:46 INFO - Running main action method: download_and_extract 04:00:46 INFO - mkdir: /builds/slave/test/build/tests 04:00:46 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')]} 04:00:46 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json matches https://queue.taskcluster.net 04:00:46 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:00:46 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json 04:00:46 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:00:46 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json'}, attempt #1 04:00:47 INFO - Downloaded 1165 bytes. 04:00:47 INFO - Reading from file /builds/slave/test/build/firefox-48.0.en-US.mac.test_packages.json 04:00:47 INFO - Using the following test package requirements: 04:00:47 INFO - {u'common': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:00:47 INFO - u'cppunittest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:00:47 INFO - u'firefox-48.0.en-US.mac.cppunittest.tests.zip'], 04:00:47 INFO - u'gtest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:00:47 INFO - u'firefox-48.0.en-US.mac.gtest.tests.zip'], 04:00:47 INFO - u'jittest': [u'firefox-48.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 04:00:47 INFO - u'mochitest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:00:47 INFO - u'firefox-48.0.en-US.mac.mochitest.tests.zip'], 04:00:47 INFO - u'mozbase': [u'firefox-48.0.en-US.mac.common.tests.zip'], 04:00:47 INFO - u'reftest': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:00:47 INFO - u'firefox-48.0.en-US.mac.reftest.tests.zip'], 04:00:47 INFO - u'talos': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:00:47 INFO - u'firefox-48.0.en-US.mac.talos.tests.zip'], 04:00:47 INFO - u'web-platform': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:00:47 INFO - u'firefox-48.0.en-US.mac.web-platform.tests.zip'], 04:00:47 INFO - u'xpcshell': [u'firefox-48.0.en-US.mac.common.tests.zip', 04:00:47 INFO - u'firefox-48.0.en-US.mac.xpcshell.tests.zip']} 04:00:47 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip'] for test suite category: common 04:00:47 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:47 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:00:47 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:00:47 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:00:47 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 04:00:47 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 04:00:48 INFO - Downloaded 18314870 bytes. 04:00:48 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:00:48 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:00:51 INFO - Return code: 0 04:00:51 INFO - Downloading packages: [u'firefox-48.0.en-US.mac.common.tests.zip', u'firefox-48.0.en-US.mac.talos.tests.zip'] for test suite category: talos 04:00:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:51 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip matches https://queue.taskcluster.net 04:00:51 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:00:51 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip 04:00:51 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip 04:00:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.common.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip'}, attempt #1 04:00:52 INFO - Downloaded 18314870 bytes. 04:00:52 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:00:52 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.common.tests.zip -d /builds/slave/test/build/tests 04:00:56 INFO - Return code: 0 04:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:56 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip matches https://queue.taskcluster.net 04:00:56 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:00:56 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip 04:00:56 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip to /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip 04:00:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': u'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.talos.tests.zip', 'file_name': u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip'}, attempt #1 04:00:57 INFO - Downloaded 10840145 bytes. 04:00:57 INFO - Running command: ['unzip', '-q', '-o', u'/builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip', '-d', '/builds/slave/test/build/tests'] 04:00:57 INFO - Copy/paste: unzip -q -o /builds/slave/test/build/firefox-48.0.en-US.mac.talos.tests.zip -d /builds/slave/test/build/tests 04:00:57 INFO - Return code: 0 04:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:00:57 INFO - https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg matches https://queue.taskcluster.net 04:00:57 INFO - URL Candidate: http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:00:57 INFO - trying http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:00:57 INFO - Downloading http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg to /builds/slave/test/build/firefox-48.0.en-US.mac.dmg 04:00:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'http://queue.taskcluster.net.proxxy1.srv.releng.scl3.mozilla.com/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg'}, attempt #1 04:01:00 INFO - Downloaded 86255188 bytes. 04:01:00 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:01:00 INFO - mkdir: /builds/slave/test/properties 04:01:00 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:01:00 INFO - Writing to file /builds/slave/test/properties/build_url 04:01:00 INFO - Contents: 04:01:00 INFO - build_url:https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg 04:01:00 INFO - Running post-action listener: _resource_record_post_action 04:01:00 INFO - Running post-action listener: set_extra_try_arguments 04:01:00 INFO - ##### 04:01:00 INFO - ##### Running populate-webroot step. 04:01:00 INFO - ##### 04:01:00 INFO - Running pre-action listener: _resource_record_pre_action 04:01:00 INFO - Running main action method: populate_webroot 04:01:00 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:01:00 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:01:00 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:01:00 INFO - '--tppagecycles', 04:01:00 INFO - '7'], 04:01:00 INFO - 'tests': ['tsvgm']}}, 04:01:00 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:01:00 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:01:00 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:01:00 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:01:00 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:01:00 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:01:00 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:00 INFO - 'talos_options': ['--disable-e10s'], 04:01:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:00 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:00 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:01:00 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:00 INFO - 'talos_options': ['--disable-e10s'], 04:01:00 INFO - 'tests': ['damp', 'tps']}, 04:01:00 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:00 INFO - 'tests': ['damp', 'tps']}, 04:01:00 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:01:00 INFO - 'tests': ['dromaeo_dom']}, 04:01:00 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:01:00 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:01:00 INFO - 'tests': ['a11yr', 04:01:00 INFO - 'ts_paint', 04:01:00 INFO - 'tpaint', 04:01:00 INFO - 'sessionrestore', 04:01:00 INFO - 'sessionrestore_no_auto_restore', 04:01:00 INFO - 'tabpaint']}, 04:01:00 INFO - 'other-e10s': {'tests': ['a11yr', 04:01:00 INFO - 'ts_paint', 04:01:00 INFO - 'tpaint', 04:01:00 INFO - 'sessionrestore', 04:01:00 INFO - 'sessionrestore_no_auto_restore', 04:01:00 INFO - 'tabpaint']}, 04:01:00 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:01:00 INFO - 'ts_paint', 04:01:00 INFO - 'tpaint', 04:01:00 INFO - 'sessionrestore', 04:01:00 INFO - 'sessionrestore_no_auto_restore', 04:01:00 INFO - 'tabpaint']}, 04:01:00 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:01:00 INFO - 'ts_paint', 04:01:00 INFO - 'tpaint', 04:01:00 INFO - 'sessionrestore', 04:01:00 INFO - 'sessionrestore_no_auto_restore', 04:01:00 INFO - 'tabpaint']}, 04:01:00 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:01:00 INFO - 'tests': ['a11yr', 04:01:00 INFO - 'ts_paint', 04:01:00 INFO - 'tpaint', 04:01:00 INFO - 'sessionrestore', 04:01:00 INFO - 'sessionrestore_no_auto_restore', 04:01:00 INFO - 'tabpaint']}, 04:01:00 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:01:00 INFO - 'tests': ['a11yr', 04:01:00 INFO - 'ts_paint', 04:01:00 INFO - 'tpaint', 04:01:00 INFO - 'sessionrestore', 04:01:00 INFO - 'sessionrestore_no_auto_restore', 04:01:00 INFO - 'tabpaint']}, 04:01:00 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:01:00 INFO - 'tests': ['tsvgx', 04:01:00 INFO - 'tsvgr_opacity', 04:01:00 INFO - 'tart', 04:01:00 INFO - 'tscrollx', 04:01:00 INFO - 'cart']}, 04:01:00 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:01:00 INFO - 'tsvgr_opacity', 04:01:00 INFO - 'tart', 04:01:00 INFO - 'tscrollx', 04:01:00 INFO - 'cart']}, 04:01:00 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:00 INFO - 'talos_options': ['--disable-e10s'], 04:01:00 INFO - 'tests': ['tp5o']}, 04:01:00 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:00 INFO - 'tests': ['tp5o']}, 04:01:00 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:00 INFO - 'talos_options': ['--disable-e10s', 04:01:00 INFO - '--xperf_path', 04:01:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:00 INFO - 'tests': ['tp5n']}, 04:01:00 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 04:01:00 INFO - 'talos_options': ['--xperf_path', 04:01:00 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:01:00 INFO - 'tests': ['tp5n']}}, 04:01:00 INFO - 'talos.zip': {'path': '', 04:01:00 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:01:00 INFO - Running post-action listener: _resource_record_post_action 04:01:00 INFO - ##### 04:01:00 INFO - ##### Running create-virtualenv step. 04:01:00 INFO - ##### 04:01:00 INFO - Running pre-action listener: _resource_record_pre_action 04:01:00 INFO - Running main action method: create_virtualenv 04:01:00 INFO - Creating virtualenv /builds/slave/test/build/venv 04:01:00 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:01:00 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:01:01 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:01:01 INFO - Using real prefix '/tools/python27' 04:01:01 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:01:01 INFO - Installing distribute.............................................................................................................................................................................................done. 04:01:04 INFO - Installing pip.................done. 04:01:04 INFO - Return code: 0 04:01:04 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10da61a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da71420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc331491af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d900e00>, '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 0x10d769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/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.8weUf5GyPt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:01:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:01:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/Render', 04:01:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:04 INFO - 'HOME': '/Users/cltbld', 04:01:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:04 INFO - 'LOGNAME': 'cltbld', 04:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:04 INFO - 'MOZ_NO_REMOTE': '1', 04:01:04 INFO - 'NO_EM_RESTART': '1', 04:01:04 INFO - 'PAGER': '/bin/cat', 04:01:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:04 INFO - 'PWD': '/builds/slave/test', 04:01:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:04 INFO - 'SHELL': '/bin/bash', 04:01:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8weUf5GyPt/Listeners', 04:01:04 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 04:01:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:04 INFO - 'USER': 'cltbld', 04:01:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:04 INFO - 'XPC_FLAGS': '0x0', 04:01:04 INFO - 'XPC_SERVICE_NAME': '0', 04:01:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:04 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 04:01:04 INFO - Cleaning up... 04:01:04 INFO - Return code: 0 04:01:04 INFO - Installing psutil>=0.7.1 into virtualenv /builds/slave/test/build/venv 04:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10da61a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da71420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc331491af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d900e00>, '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 0x10d769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/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.8weUf5GyPt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:01:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:01:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:01:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/Render', 04:01:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:04 INFO - 'HOME': '/Users/cltbld', 04:01:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:04 INFO - 'LOGNAME': 'cltbld', 04:01:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:04 INFO - 'MOZ_NO_REMOTE': '1', 04:01:04 INFO - 'NO_EM_RESTART': '1', 04:01:04 INFO - 'PAGER': '/bin/cat', 04:01:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:04 INFO - 'PWD': '/builds/slave/test', 04:01:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:04 INFO - 'SHELL': '/bin/bash', 04:01:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8weUf5GyPt/Listeners', 04:01:04 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 04:01:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:04 INFO - 'USER': 'cltbld', 04:01:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:04 INFO - 'XPC_FLAGS': '0x0', 04:01:04 INFO - 'XPC_SERVICE_NAME': '0', 04:01:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:05 INFO - Downloading/unpacking psutil>=0.7.1 04:01:05 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 04:01:05 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 04:01:05 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 04:01:05 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 04:01:05 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 04:01:05 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 04:01:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:01:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:08 INFO - Installing collected packages: psutil 04:01:08 INFO - Running setup.py install for psutil 04:01:08 INFO - building 'psutil._psutil_osx' extension 04:01:08 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 04:01:08 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 04:01:08 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 04:01:08 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 04:01:08 INFO - building 'psutil._psutil_posix' extension 04:01:08 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 04:01:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:01:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:01:08 INFO - ^ 04:01:08 INFO - 1 warning generated. 04:01:08 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 04:01:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:01:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:01:08 INFO - Successfully installed psutil 04:01:08 INFO - Cleaning up... 04:01:09 INFO - Return code: 0 04:01:09 INFO - Installing mozsystemmonitor==0.0.0 into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10da61a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da71420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc331491af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d900e00>, '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 0x10d769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/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.8weUf5GyPt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:01:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:01:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:01:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/Render', 04:01:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:09 INFO - 'HOME': '/Users/cltbld', 04:01:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:09 INFO - 'LOGNAME': 'cltbld', 04:01:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:09 INFO - 'MOZ_NO_REMOTE': '1', 04:01:09 INFO - 'NO_EM_RESTART': '1', 04:01:09 INFO - 'PAGER': '/bin/cat', 04:01:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:09 INFO - 'PWD': '/builds/slave/test', 04:01:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:09 INFO - 'SHELL': '/bin/bash', 04:01:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8weUf5GyPt/Listeners', 04:01:09 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 04:01:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:09 INFO - 'USER': 'cltbld', 04:01:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:09 INFO - 'XPC_FLAGS': '0x0', 04:01:09 INFO - 'XPC_SERVICE_NAME': '0', 04:01:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:09 INFO - Downloading/unpacking mozsystemmonitor==0.0.0 04:01:09 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 04:01:09 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 04:01:09 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 04:01:09 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 04:01:09 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 04:01:09 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 04:01:11 INFO - Downloading mozsystemmonitor-0.0.tar.gz 04:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:01:11 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=0.7.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.0.0) 04:01:11 INFO - Installing collected packages: mozsystemmonitor 04:01:11 INFO - Running setup.py install for mozsystemmonitor 04:01:11 INFO - Successfully installed mozsystemmonitor 04:01:11 INFO - Cleaning up... 04:01:12 INFO - Return code: 0 04:01:12 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10da61a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da71420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc331491af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d900e00>, '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 0x10d769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/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.8weUf5GyPt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:01:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/Render', 04:01:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:12 INFO - 'HOME': '/Users/cltbld', 04:01:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:12 INFO - 'LOGNAME': 'cltbld', 04:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:12 INFO - 'MOZ_NO_REMOTE': '1', 04:01:12 INFO - 'NO_EM_RESTART': '1', 04:01:12 INFO - 'PAGER': '/bin/cat', 04:01:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:12 INFO - 'PWD': '/builds/slave/test', 04:01:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:12 INFO - 'SHELL': '/bin/bash', 04:01:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8weUf5GyPt/Listeners', 04:01:12 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 04:01:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:12 INFO - 'USER': 'cltbld', 04:01:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:12 INFO - 'XPC_FLAGS': '0x0', 04:01:12 INFO - 'XPC_SERVICE_NAME': '0', 04:01:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:12 INFO - Downloading/unpacking blobuploader==1.2.4 04:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:14 INFO - Downloading blobuploader-1.2.4.tar.gz 04:01:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:01:14 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:01:14 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 04:01:14 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 04:01:14 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 04:01:14 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 04:01:14 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 04:01:14 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 04:01:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:01:15 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:15 INFO - Downloading docopt-0.6.1.tar.gz 04:01:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:01:16 INFO - Installing collected packages: blobuploader, requests, docopt 04:01:16 INFO - Running setup.py install for blobuploader 04:01:16 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:01:16 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:01:16 INFO - Running setup.py install for requests 04:01:16 INFO - Running setup.py install for docopt 04:01:16 INFO - Successfully installed blobuploader requests docopt 04:01:16 INFO - Cleaning up... 04:01:16 INFO - Return code: 0 04:01:16 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:16 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 0x10da61a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da71420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc331491af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d900e00>, '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 0x10d769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/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.8weUf5GyPt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:01:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--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 04:01:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --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 04:01:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/Render', 04:01:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:16 INFO - 'HOME': '/Users/cltbld', 04:01:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:16 INFO - 'LOGNAME': 'cltbld', 04:01:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:16 INFO - 'MOZ_NO_REMOTE': '1', 04:01:16 INFO - 'NO_EM_RESTART': '1', 04:01:16 INFO - 'PAGER': '/bin/cat', 04:01:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:16 INFO - 'PWD': '/builds/slave/test', 04:01:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:16 INFO - 'SHELL': '/bin/bash', 04:01:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8weUf5GyPt/Listeners', 04:01:16 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 04:01:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:16 INFO - 'USER': 'cltbld', 04:01:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:16 INFO - 'XPC_FLAGS': '0x0', 04:01:16 INFO - 'XPC_SERVICE_NAME': '0', 04:01:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:17 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-Wr_wO2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:17 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-VPQKIr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:17 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-84mBCp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:17 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-Fiu0nM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:17 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-TMC1v4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:17 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-No2vnQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:17 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-C6MsTd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:17 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-ygtpue-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-iSukcN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-B3xmPN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-QkD8oH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-44sauZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-ZWqfsK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-yYvVA0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-GbHxuv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-qs5iSh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:18 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-1YmyUB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:18 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:01:18 INFO - Running setup.py install for manifestparser 04:01:19 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:01:19 INFO - Running setup.py install for mozcrash 04:01:19 INFO - Running setup.py install for mozdebug 04:01:19 INFO - Running setup.py install for mozdevice 04:01:19 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:01:19 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:01:19 INFO - Running setup.py install for mozfile 04:01:19 INFO - Running setup.py install for mozhttpd 04:01:19 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:01:19 INFO - Running setup.py install for mozinfo 04:01:19 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:01:20 INFO - Running setup.py install for mozInstall 04:01:20 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:01:20 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:01:20 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:01:20 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:01:20 INFO - Running setup.py install for mozleak 04:01:20 INFO - Running setup.py install for mozlog 04:01:20 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:01:20 INFO - Running setup.py install for moznetwork 04:01:20 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:01:20 INFO - Running setup.py install for mozprocess 04:01:20 INFO - Running setup.py install for mozprofile 04:01:20 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:01:20 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:01:20 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:01:20 INFO - Running setup.py install for mozrunner 04:01:21 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:01:21 INFO - Running setup.py install for mozscreenshot 04:01:21 INFO - Running setup.py install for moztest 04:01:21 INFO - Running setup.py install for mozversion 04:01:21 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:01:21 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:01:21 INFO - Cleaning up... 04:01:21 INFO - Return code: 0 04:01:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01: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')]} 04:01:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01: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')]} 04:01:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:21 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10da61a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da71420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc331491af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d900e00>, '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 0x10d769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/config', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/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.8weUf5GyPt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:01:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:01:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:01:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/Render', 04:01:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:21 INFO - 'HOME': '/Users/cltbld', 04:01:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:21 INFO - 'LOGNAME': 'cltbld', 04:01:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:21 INFO - 'MOZ_NO_REMOTE': '1', 04:01:21 INFO - 'NO_EM_RESTART': '1', 04:01:21 INFO - 'PAGER': '/bin/cat', 04:01:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:21 INFO - 'PWD': '/builds/slave/test', 04:01:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:21 INFO - 'SHELL': '/bin/bash', 04:01:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8weUf5GyPt/Listeners', 04:01:21 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 04:01:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:21 INFO - 'USER': 'cltbld', 04:01:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:21 INFO - 'XPC_FLAGS': '0x0', 04:01:21 INFO - 'XPC_SERVICE_NAME': '0', 04:01:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:01:21 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-i3yRWg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:01:21 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)) 04:01:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:01:21 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-9dbaRl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:01:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 04:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:01:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-_pGyLq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:01:22 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)) 04:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:01:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-bov0ML-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:01:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 04:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:01:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-Ii3uWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:01:22 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)) 04:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:01:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-QLbjvV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:01:22 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)) 04:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:01:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-GNNArs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:01:22 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)) 04:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:01:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-xwq6q9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:01:22 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)) 04:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:01:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-o1DXmQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:01:22 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)) 04:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:01:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-fFW5ub-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:01:22 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.1 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)) 04:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:01:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-5tMw12-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:01:22 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)) 04:01:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:01:22 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-h5p31E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:01:23 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)) 04:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:01:23 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-OXdV5N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:01:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 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)) 04:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:01:23 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-1rLsU_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:01:23 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)) 04:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:23 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-fARtmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:01:23 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)) 04:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:01:23 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-WIVueJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:01:23 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)) 04:01:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:01:23 INFO - Running setup.py (path:/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/pip-M3ccNL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:01:23 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)) 04:01:23 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:01:23 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.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:01:23 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)) 04:01:23 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:01:23 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:01:23 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:01:23 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 04:01:23 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 04:01:23 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 04:01:23 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 04:01:23 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 04:01:23 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 04:01:26 INFO - Downloading blessings-1.6.tar.gz 04:01:26 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:01:26 INFO - Installing collected packages: blessings 04:01:26 INFO - Running setup.py install for blessings 04:01:26 INFO - Successfully installed blessings 04:01:26 INFO - Cleaning up... 04:01:26 INFO - Return code: 0 04:01:26 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:01:26 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:26 INFO - Reading from file tmpfile_stdout 04:01:26 INFO - Current package versions: 04:01:26 INFO - blessings == 1.6 04:01:26 INFO - blobuploader == 1.2.4 04:01:26 INFO - docopt == 0.6.1 04:01:26 INFO - manifestparser == 1.1 04:01:26 INFO - mozInstall == 1.12 04:01:26 INFO - mozcrash == 0.17 04:01:26 INFO - mozdebug == 0.1 04:01:26 INFO - mozdevice == 0.48 04:01:26 INFO - mozfile == 1.2 04:01:26 INFO - mozhttpd == 0.7 04:01:26 INFO - mozinfo == 0.9 04:01:26 INFO - mozleak == 0.1 04:01:26 INFO - mozlog == 3.1 04:01:26 INFO - moznetwork == 0.27 04:01:26 INFO - mozprocess == 0.22 04:01:26 INFO - mozprofile == 0.28 04:01:26 INFO - mozrunner == 6.11 04:01:26 INFO - mozscreenshot == 0.1 04:01:26 INFO - mozsystemmonitor == 0.0 04:01:26 INFO - moztest == 0.7 04:01:26 INFO - mozversion == 1.4 04:01:26 INFO - psutil == 3.1.1 04:01:26 INFO - requests == 1.2.3 04:01:26 INFO - wsgiref == 0.1.2 04:01:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:01:26 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')]} 04:01:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:26 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')]} 04:01:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:26 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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 0x10da61a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da71420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc331491af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d900e00>, '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 0x10d769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build/tests/talos', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/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.8weUf5GyPt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:01:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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 04:01:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 04:01:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/Render', 04:01:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:26 INFO - 'HOME': '/Users/cltbld', 04:01:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:26 INFO - 'LOGNAME': 'cltbld', 04:01:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:26 INFO - 'MOZ_NO_REMOTE': '1', 04:01:26 INFO - 'NO_EM_RESTART': '1', 04:01:26 INFO - 'PAGER': '/bin/cat', 04:01:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:26 INFO - 'PWD': '/builds/slave/test', 04:01:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:26 INFO - 'SHELL': '/bin/bash', 04:01:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8weUf5GyPt/Listeners', 04:01:26 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 04:01:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:26 INFO - 'USER': 'cltbld', 04:01:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:26 INFO - 'XPC_FLAGS': '0x0', 04:01:26 INFO - 'XPC_SERVICE_NAME': '0', 04:01:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:01:27 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 2)) 04:01:27 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 3)) 04:01:27 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 4)) 04:01:27 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 5)) 04:01:27 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 6)) 04:01:27 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 7)) 04:01:27 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 8)) 04:01:27 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 9)) 04:01:27 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.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:01:27 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 4)) 04:01:27 INFO - Cleaning up... 04:01:27 INFO - Return code: 0 04:01:27 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:27 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:27 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:27 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:27 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:27 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da61a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da71420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc331491af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d900e00>, '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 0x10d769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/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.8weUf5GyPt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:01:27 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'jsonschema'] in /builds/slave/test/build 04:01:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 jsonschema 04:01:27 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/Render', 04:01:27 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:27 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:27 INFO - 'HOME': '/Users/cltbld', 04:01:27 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:27 INFO - 'LOGNAME': 'cltbld', 04:01:27 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:27 INFO - 'MOZ_NO_REMOTE': '1', 04:01:27 INFO - 'NO_EM_RESTART': '1', 04:01:27 INFO - 'PAGER': '/bin/cat', 04:01:27 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:27 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:27 INFO - 'PWD': '/builds/slave/test', 04:01:27 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:27 INFO - 'SHELL': '/bin/bash', 04:01:27 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8weUf5GyPt/Listeners', 04:01:27 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 04:01:27 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:27 INFO - 'USER': 'cltbld', 04:01:27 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:27 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:27 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:27 INFO - 'XPC_FLAGS': '0x0', 04:01:27 INFO - 'XPC_SERVICE_NAME': '0', 04:01:27 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:27 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:27 INFO - Downloading/unpacking jsonschema 04:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:29 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:01:29 INFO - Downloading/unpacking functools32 (from jsonschema) 04:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:29 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:29 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:29 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:29 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:30 INFO - Downloading functools32-3.2.3-2.tar.gz 04:01:30 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:01:30 INFO - warning: no files found matching '*.txt' 04:01:30 INFO - no previously-included directories found matching 'build' 04:01:30 INFO - no previously-included directories found matching 'dist' 04:01:30 INFO - no previously-included directories found matching '.git*' 04:01:30 INFO - Installing collected packages: jsonschema, functools32 04:01:30 INFO - Running setup.py install for functools32 04:01:30 INFO - warning: no files found matching '*.txt' 04:01:30 INFO - no previously-included directories found matching 'build' 04:01:30 INFO - no previously-included directories found matching 'dist' 04:01:30 INFO - no previously-included directories found matching '.git*' 04:01:30 INFO - Successfully installed jsonschema functools32 04:01:30 INFO - Cleaning up... 04:01:30 INFO - Return code: 0 04:01:30 INFO - Installing flake8 into virtualenv /builds/slave/test/build/venv 04:01:30 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')]} 04:01:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:01:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:30 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')]} 04:01:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:01:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:01:30 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'flake8']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10da61a30>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10da71420>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc331491af0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10d900e00>, '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 0x10d769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8fbb20>, 'level': 'critical'}], 'cwd': '/builds/slave/test/build', 'env': {'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 'LOGNAME': 'cltbld', 'USER': 'cltbld', 'XPC_SERVICE_NAME': '0', 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 'HOME': '/Users/cltbld', 'NO_EM_RESTART': '1', 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 'XPCOM_DEBUG_BREAK': 'warn', 'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/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.8weUf5GyPt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:01:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--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', 'flake8'] in /builds/slave/test/build 04:01:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --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 flake8 04:01:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/Render', 04:01:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:30 INFO - 'HOME': '/Users/cltbld', 04:01:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:30 INFO - 'LOGNAME': 'cltbld', 04:01:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:30 INFO - 'MOZ_NO_REMOTE': '1', 04:01:30 INFO - 'NO_EM_RESTART': '1', 04:01:30 INFO - 'PAGER': '/bin/cat', 04:01:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:30 INFO - 'PWD': '/builds/slave/test', 04:01:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:30 INFO - 'SHELL': '/bin/bash', 04:01:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8weUf5GyPt/Listeners', 04:01:30 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 04:01:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:30 INFO - 'USER': 'cltbld', 04:01:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:30 INFO - 'XPC_FLAGS': '0x0', 04:01:30 INFO - 'XPC_SERVICE_NAME': '0', 04:01:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:01:31 INFO - Downloading/unpacking flake8 04:01:31 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 04:01:31 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 04:01:31 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 04:01:31 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 04:01:31 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 04:01:31 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 04:01:33 INFO - Downloading flake8-2.5.0-py2.py3-none-any.whl 04:01:33 INFO - Downloading/unpacking mccabe>=0.2.1,<0.4 (from flake8) 04:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:33 INFO - Downloading mccabe-0.3.1-py2.py3-none-any.whl 04:01:33 INFO - Downloading/unpacking pyflakes>=0.8.1,<1.1 (from flake8) 04:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:33 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:33 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:01:33 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:01:33 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:01:34 INFO - Downloading/unpacking pep8>=1.5.7,!=1.6.0,!=1.6.1,!=1.6.2 (from flake8) 04:01:34 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 04:01:34 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 04:01:34 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 04:01:34 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 04:01:34 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 04:01:34 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 04:01:34 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/pep8/setup.py) egg_info for package pep8 04:01:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:01:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:01:34 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:01:34 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:01:34 INFO - no previously-included directories found matching 'docs/_build' 04:01:34 INFO - Installing collected packages: flake8, mccabe, pyflakes, pep8 04:01:34 INFO - Running setup.py install for pep8 04:01:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'docs' 04:01:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'docs' 04:01:35 INFO - warning: no previously-included files matching '*.pyc' found under directory 'testsuite' 04:01:35 INFO - warning: no previously-included files matching '*.pyo' found under directory 'testsuite' 04:01:35 INFO - no previously-included directories found matching 'docs/_build' 04:01:35 INFO - Installing pep8 script to /builds/slave/test/build/venv/bin 04:01:35 INFO - Successfully installed flake8 mccabe pyflakes pep8 04:01:35 INFO - Cleaning up... 04:01:35 INFO - Return code: 0 04:01:35 INFO - Running post-action listener: _resource_record_post_action 04:01:35 INFO - Running post-action listener: _start_resource_monitoring 04:01:35 INFO - Starting resource monitoring. 04:01:35 INFO - ##### 04:01:35 INFO - ##### Running install step. 04:01:35 INFO - ##### 04:01:35 INFO - Running pre-action listener: _resource_record_pre_action 04:01:35 INFO - Running main action method: install 04:01:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:01:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:01:35 INFO - Reading from file tmpfile_stdout 04:01:35 INFO - Detecting whether we're running mozinstall >=1.0... 04:01:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:01:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:01:35 INFO - Reading from file tmpfile_stdout 04:01:35 INFO - Output received: 04:01:35 INFO - Usage: mozinstall [options] installer 04:01:35 INFO - Options: 04:01:35 INFO - -h, --help show this help message and exit 04:01:35 INFO - -d DEST, --destination=DEST 04:01:35 INFO - Directory to install application into. [default: 04:01:35 INFO - "/builds/slave/test"] 04:01:35 INFO - --app=APP Application being installed. [default: firefox] 04:01:35 INFO - mkdir: /builds/slave/test/build/application 04:01:35 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-48.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:01:35 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-48.0.en-US.mac.dmg --destination /builds/slave/test/build/application 04:01:57 INFO - Reading from file tmpfile_stdout 04:01:57 INFO - Output received: 04:01:57 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 04:01:57 INFO - Running post-action listener: _resource_record_post_action 04:01:57 INFO - ##### 04:01:57 INFO - ##### Running run-tests step. 04:01:57 INFO - ##### 04:01:57 INFO - Running pre-action listener: _resource_record_pre_action 04:01:57 INFO - Running main action method: run_tests 04:01:57 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:01:57 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:01:57 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:01:57 INFO - 2016-07-27 04:01:57.516 screenresolution[2343:15952] starting screenresolution argv=screenresolution get 04:01:57 INFO - 2016-07-27 04:01:57.519 screenresolution[2343:15952] Display 0: 1600x1200x32@60 04:01:57 INFO - 2016-07-27 04:01:57.525 screenresolution[2344:15955] starting screenresolution argv=screenresolution list 04:01:57 INFO - Available Modes on Display 0 04:01:57 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:01:57 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:01:57 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:01:57 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:01:57 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:01:57 INFO - Intel Iris: 04:01:57 INFO - Chipset Model: Intel Iris 04:01:57 INFO - Type: GPU 04:01:57 INFO - Bus: Built-In 04:01:57 INFO - VRAM (Dynamic, Max): 1536 MB 04:01:57 INFO - Vendor: Intel (0x8086) 04:01:57 INFO - Device ID: 0x0a2e 04:01:57 INFO - Revision ID: 0x0009 04:01:57 INFO - Displays: 04:01:57 INFO - Display: 04:01:57 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:01:57 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:01:57 INFO - Display Serial Number: 1600x1200 60 04:01:57 INFO - Main Display: Yes 04:01:57 INFO - Mirror: Off 04:01:57 INFO - Online: Yes 04:01:57 INFO - Rotation: Supported 04:01:57 INFO - Return code: 0 04:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:01:57 INFO - Python 2.7.3 04:01:57 INFO - Return code: 0 04:01:57 INFO - grabbing minidump binary from tooltool 04:01:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pvtbuilds.pvt.build.mozilla.org', 'pvtbuilds.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org'), ('https://queue.taskcluster.net', 'queue.taskcluster.net')]} 04:01:57 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 0x10d900e00>, '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 0x10d769db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10d8fbb20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:01:57 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 04:01:57 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 04:01:57 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:01:57 INFO - Return code: 0 04:01:57 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:01:57 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:01:57 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:01:57 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:01:57 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:01:57 INFO - Running command: ['/builds/slave/test/build/venv/bin/flake8', '/builds/slave/test/build/tests/talos/talos'] 04:01:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/flake8 /builds/slave/test/build/tests/talos/talos 04:01:58 INFO - Return code: 0 04:01:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0296', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] in /builds/slave/test/build 04:01:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs-e10s --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0296 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log 04:01:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.XbId30KpPS/Render', 04:01:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:01:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:01:58 INFO - 'HOME': '/Users/cltbld', 04:01:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:01:58 INFO - 'LOGNAME': 'cltbld', 04:01:58 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:01:58 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:01:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:01:58 INFO - 'MOZ_NO_REMOTE': '1', 04:01:58 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:01:58 INFO - 'NO_EM_RESTART': '1', 04:01:58 INFO - 'PAGER': '/bin/cat', 04:01:58 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:01:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:01:58 INFO - 'PWD': '/builds/slave/test', 04:01:58 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:01:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:01:58 INFO - 'SHELL': '/bin/bash', 04:01:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.8weUf5GyPt/Listeners', 04:01:58 INFO - 'TMPDIR': '/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/', 04:01:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:01:58 INFO - 'USER': 'cltbld', 04:01:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:01:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:01:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:01:58 INFO - 'XPC_FLAGS': '0x0', 04:01:58 INFO - 'XPC_SERVICE_NAME': '0', 04:01:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:01:58 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs-e10s', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0296', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log'] with output_timeout 3600 04:01:59 INFO - mozversion application_buildid: 20160726073802 04:01:59 INFO - mozversion application_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 04:01:59 INFO - mozversion application_display_name: Firefox 04:01:59 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:01:59 INFO - mozversion application_name: Firefox 04:01:59 INFO - mozversion application_remotingname: firefox 04:01:59 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 04:01:59 INFO - mozversion application_vendor: Mozilla 04:01:59 INFO - mozversion application_version: 48.0 04:01:59 INFO - mozversion platform_buildid: 20160726073802 04:01:59 INFO - mozversion platform_changeset: 958cee08361af9ed370be06695973bcda3d3aa46 04:01:59 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 04:01:59 INFO - mozversion platform_version: 48.0 04:01:59 INFO - using testdate: 1469617319 04:01:59 INFO - actual date: 1469617319 04:01:59 INFO - starting webserver on 'localhost:49826' 04:01:59 INFO - SUITE-START | Running 2 tests 04:01:59 INFO - TEST-START | dromaeo_css 04:01:59 INFO - operating with platform_type : mac_ 04:01:59 INFO - Initialising browser for dromaeo_css test... 04:01:59 INFO - TEST-INFO | started process 2362 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/tmp7riGn7/profile http://localhost:49826/getInfo.html) 04:02:01 INFO - PROCESS | 2362 | __metrics Screen width/height:1600/1200 04:02:01 INFO - PROCESS | 2362 | colorDepth:24 04:02:01 INFO - PROCESS | 2362 | Browser inner width/height: 1024/689 04:02:01 INFO - PROCESS | 2362 | __metrics 04:02:02 ERROR - PROCESS | 2362 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:02:02 INFO - TEST-INFO | 2362: exit 0 04:02:02 INFO - Browser initialized. 04:02:02 INFO - Running cycle 1/1 for dromaeo_css test... 04:02:02 INFO - TEST-INFO | started process 2366 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/tmp7riGn7/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:02:14 INFO - PROCESS | 2366 | RSS: Main: 170893312 04:02:14 INFO - PROCESS | 2366 | 04:03:04 INFO - PROCESS | 2366 | 1469617384446 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] 04:05:14 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:49826/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49826/tests/dromaeo/cssquery-ext.html) 04:05:16 INFO - PROCESS | 2366 | RSS: Main: 184172544 04:05:16 INFO - PROCESS | 2366 | 04:08:18 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:49826/tests/dromaeo/cssquery-ext.html (next: http://localhost:49826/tests/dromaeo/cssquery-jquery.html) 04:08:18 INFO - PROCESS | 2366 | RSS: Main: 192577536 04:08:18 INFO - PROCESS | 2366 | 04:11:20 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:49826/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49826/tests/dromaeo/cssquery-mootools.html) 04:11:21 INFO - PROCESS | 2366 | RSS: Main: 194797568 04:11:21 INFO - PROCESS | 2366 | 04:14:22 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:49826/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49826/tests/dromaeo/cssquery-prototype.html) 04:14:23 INFO - PROCESS | 2366 | RSS: Main: 198279168 04:14:23 INFO - PROCESS | 2366 | 04:17:26 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:49826/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49826/tests/dromaeo/cssquery-yui.html) 04:17:26 INFO - PROCESS | 2366 | RSS: Main: 197591040 04:17:26 INFO - PROCESS | 2366 | 04:20:28 INFO - PROCESS | 2366 | Cycle 1(1): loaded http://localhost:49826/tests/dromaeo/cssquery-yui.html (next: http://localhost:49826/tests/dromaeo/cssquery-dojo.html) 04:20:29 INFO - PROCESS | 2366 | RSS: Main: 203137024 04:20:29 INFO - PROCESS | 2366 | 04:20:29 INFO - PROCESS | 2366 | __start_tp_report 04:20:29 INFO - PROCESS | 2366 | _x_x_mozilla_page_load 04:20:29 INFO - PROCESS | 2366 | _x_x_mozilla_page_load_details 04:20:29 INFO - PROCESS | 2366 | |i|pagename|runs| 04:20:29 INFO - PROCESS | 2366 | |0;dojo.html;3077.5537547055665;3656.872009479668;3688.170161713614;3714.7585406948547;3728;4852.951470485303;6042.9093563596525;6075.817725468243;6121.785737499183;6150.7539698412065;6027.849303767408;6059.66671833049;6121.265448146218;6122.65301633641;6123.295820980588;4376.5623437656295;4537.455505339364;5444.265024221739;5513.9448605514035;5565.693886836222;4326.43756311679;5462.071447853855;5524.530414914737;5563.499285064343;5617.185508101323;5540.473655002768;5541.889162216753;5581.023320918823;5593.412691667357;5608.635438696492;4581.496035436099;5468.589855760833;5533.861653458675;5540;5619.1009438490055;5302.310699609065;5373;5430.56555475561;5493.066178749622;5544.86137846553;4920.827771027997;5861.003629383015;5941.524678025748;6027.758889644409;6085.148079268906;6351.364863513658;6462.25684046336;6474.708638111297;6478.2873883872735;6485.0596663484;6376.936230637681;6444.2911279759655;6446.516511261627;6464.191976003;6483.805485835385;6061.363556826514;6144.701660918228;6163.2604087509335;6172.9074063889075;6187.907181392283;6629.303923088103;6643.2028156620545;6663.566868153554;6674.098996635489;6695.497837662195;6280.623162610258;6305.306416294204;6336.58812177207;6396.552241343062;6407.359264073649;6439.64581947988;6466.6766661666725;6481.643509606923;6489.902651460232;6505.772297969548;6262.812115636538;6365.427111559982;6386.233651961795;6396.456301214356;6403.295637479967;6331.3352098029045;6365.968170159213;6400.103985442041;6404.103425520431;6431.710573024225;5053.9747301264;5110.488951104934;5136.2295655651205;5155;5164.354455693038;4512.300593408027;4530.728156310632;4628.722276663411;4643.187442197602;4656.254999200111;6109.435031337442;6136.7948077883175;6159.384061593894;6253.499720022387;6274.996000639967;6452.483801295979;6480.384363485461;6500.967495162588;6532;6532.869342613121;6135.569531795964;6145.248604147886;6258.593191442542;6272.1219029335925;6288.874222515616;5606.1590761385305;5659.943400566024;5660.830175094754;5677.744501497443;5725.942740572625;6733.797986060524;6749.763758268437;6774.796756097325;6786.253512113663;6805.727770889109;6369.108324834434;6467.838304042437;6471.02934559801;6477;6487.416132548094;6751.257361690308;6798.8640227196165;6818.249992500921;6824.829379265558;6835.453163746988;6375.362463753588;6398.488120950406;6398.616083035033;6423.550351475352;6451.1290975717675;6296.779612713533;6453.838654033687;6457.09600655918;6481.837954050998;6526.24948130952;6254.6247225166635;6323.588966717149;6323.620582765049;6336.366363363627;6390.041493775785;5845.795397161079;6304.65324407162;6319.652419116809;6326.8734625306315;6333.683315834282;4943.406791184937;6128.442013631005;6172.074188871705;6220.564560480723;6235.407636274546;5183.948160518497;6302.842428939313;6311.0217916223055;6320.62076275425;6331;6151.354107818794;6188.535859810442;6237.5009999200865;6253.78111766086;6299.685015749103 04:20:29 INFO - PROCESS | 2366 | |1;ext.html;512.5182328611105;527.678116349027;545.68623041751;598.8562744941215;608.8660494691168;33909.830450847745;42149.57850421499;42172.73481795543;42202.36696449548;42231.577684223186;33266.16834579137;42602.573974260245;43183.3522497162;43235.35146972798;43260;9716.757081072978;9907.851382229272;9914;9984.600615975389;10027.247956403262;9806.705798826046;9937.850932235986;10020.69937901864;10031.74920626983;10085.546150423212;10074.496275186248;10097.646582369618;10139.543720532594;10143;10147.289689721723;10013.599456021822;10040.347377420481;10089.394636321844;10097.444640544767;10123.240756943258;9863.35888167274;9929.602815887356;9998;10003.74990625233;10006.9499652502;41924.79037604823;42381.364279535526;42442.57557424417;42551;42678.78660606708;2835.3478699899138;3171;3196.8081915085168;3255.576775019256;3394.4908263760385;28893.855530722423;29037.274068148254;29656.555151672743;30251.394972100654;30954.690453095405;2828.6605607327047;2832.419354032439;2833.4333133373407;2888.6966868478926;2899.362140329124;446104;450147;453608.7319563381;454123;454301;39154.21691566153;40056.59943400587;73687.89468157983;74316.62841685866;74327.25672743203;39634.801825991264;39723.40414893779;39822.60177398189;40108.59891401107;40111.79944100319;16105.114218718083;16252.512424627044;16300.043994720709;16301.83698163027;16337.836621633869;13430.798538021938;13472.797908031387;13531.32343382827;13548.661283467993;13559.525416610371;7532.548047117081;8791.252743516872;9007.954960225157;9050.049744776836;9076.41003334781;3743.3903421529003;3782.3759079751535;3789.77261364319;3790.711158206223;3792.033031576985;981.3326937682302;1078.309881675728;1107.4518113533852;1131.7550694236274;1141.452102990569;31558.36883262322;31568;31588.684113158575;32124;32203.838980805416;1118.3345909184022;1133.5919069135105;1151.228676786555;1172.0799172649429;1189.2270024484155;15763.290651920692;16193.433229836899;16458;16630.75053874193;16697.83302166987;635798;736980;741996;750717;755086;66231.66884165548;66565;67150;67390;67603.66198169076;1326.8076128961247;1520.3386526860852;1525.046845721424;1530.8163020437396;1531.1502116325546;31672.683273166975;32744;32747.853825116006;33163;33317.666823331456;58286.708566456895;58433;58845;58875;59185.81628367322;590102;590282;591195;591673;592142;29010.709892900803;29494.11517654474;29956.101316960525;30027.549586756653;30195.245118872204;48905.266421004424;49343.7532812348;50852.23721644104;50953;51080.74459627678;32318.030459086265;34381.2809359526;36039.459408109426;40572;41523.68491480587;40385.59614403819;40496.79751601223;40784.79607601943;40893.59106408898;40927.59072409238;35089.94730158099;40044.59955400409;40051.79974100111;40468.797656011535;41341.37987930243;32145;33917.49123763195;34230.486542702376;35224.64775352316;35288;26334.473310534064;26549.60175597406;26589.93640254368;26711;26957.865210673823 04:20:29 INFO - PROCESS | 2366 | |2;jquery.html;359.6349705049374;424.06625786413974;424.3126135660231;434.952155262921;439.1502442773234;19683.21267149316;20761.273355432582;20866.47833804154;21598.784012159875;23052.308430747064;12283.385830708474;12609;15783.684326313467;21095.367138985817;21387.893060534676;5447.373552041507;5485.588580856432;5734.168545560891;5772.797952071678;5773.566982476331;5503.752331145108;5566.610337276392;5643.774249030034;5654.067078931971;5669.603127781057;5480.876420333842;5620.57845661575;5632.493075623193;5668.57485688573;5673.319201695782;5636.633618814764;5683.318001839764;5683.687397193153;5698.857528561778;5709.286339207599;5506.174073888908;5561.110222364402;5577.553795696375;5580.665160090408;5591.245181900432;14180.361883715257;14254.786178207336;14585.70828583433;14675.706485870329;16964.915175424045;2146.7209262795736;2187.6171669957853;2464.9753502464923;2493.4389762303517;2674.17100698784;10805.783884322269;10874.782504349947;13867.890568754476;14565.397806241304;15735.44925927587;1776.2184638759034;1805.3681211575974;1809.5566586186337;1821.0483251344615;1902.2771346888233;98992;122720;125865;127396.72603273942;130150;8920.464772113693;9852.95073524642;11748.060155187564;12238.75522489563;12262.632121036384;12948.676283092998;14442.783358249635;15587.220638968232;15814.97202681822;15902.681946361008;8849;9198.770030749285;9278.396904201205;9285.72142835716;9324.766880828034;9239.815203695889;9249.630014799333;9250.90749092514;9252.768680783034;9304.348695591243;3978.5026871641044;4935.90128197434;4946.282788995647;4957.603391728653;4981.028699403654;2066.524699319165;2121.7241758571595;2131.541718530523;2177.6951226828255;2181.4328274648706;938.9765255868658;978.3640633588083;1033.9689809305733;1044.5717255925035;1062.4103622489592;17251.65496690059;18115.365962191525;19783.865343012607;20515.692264616042;22330.44173895633;999.2263731875834;1004.2417974429259;1015.1016350529834;1050.8318669012922;1094.5567045346647;11433.371164586028;11740.471678774476;11763.764724705457;11843.46704398304;11882.940585297018;652428.7378563076;687374;688422;699801;706206;125032.37483812522;135583.32208339093;139178;148656;152565;1008.5763979128636;1025.8717660292464;1034.1468288661883;1038.6053299746047;1070.2775626452114;19039.809601903802;19549.218031279157;19667.80332196717;19803.207871684972;19969;53900.46099538954;55444;56168.5957851057;56517.76116791339;56609.86780264289;77854.22145778696;79451.80822287787;80258;80341.59829200816;82006;6622.8344291393105;8582.871256931026;8749.8687519686;8799.868001979847;8943.910560894568;12312.384380781104;12907.677308067374;13051.347432628521;13346.265955372548;13357.66605834862;5705.657660540381;6898.758543450955;11533.826992595286;11637.359945202756;11749.412529373327;6078.7264573093435;6996.775564276333;11455.541778328774;11480.598179063692;11656.825147622623;9334.953325233331;11247.887521124683;11866.703332416413;11878.940605296919;12260.754784904073;8478.533680647624;8583.18459746323;8677.566121694017;8800.855888734424;9046.773830654287;10256.333338332985;10418.843717344398;10869.456527173768;11200.935911088434;12059.81910271329 04:20:29 INFO - PROCESS | 2366 | |3;mootools.html;1605.6307049378643;1647.0694057857313;1703.863690904727;2064.7212626295445;2069.5033192033916;8509.829803403929;9208.171264586186;9322;9527.618895244183;9535.47554884481;7830.56931868747;9334.439933603971;9458.81082378352;9480.383775054617;9492.762680932963;2592.5463043967325;2610.543154947886;2613.751693589106;2617.738226177386;2619.7773189278932;2555.080171138389;2613.9346516337055;2616.738326167387;2624.173385383598;2635.7364263573586;2001.6697244954564;2327.697399338084;2573.523898078852;2595.909143179989;2615.5292047431453;2265.478939843829;2503.086373473678;2592.5333439980795;2606.0357667662993;2618.358502166972;2569.7301783312855;2601.6357709920626;2601.9349516262055;2608.4522250327454;2638.1557901471538;8157.021157461143;9482.288828337832;9501.952490237505;9558.852937647458;9586.76033099171;4892.556695774755;5652.773889044474;5715.857103572403;5866.853328666774;5890.145928840294;3147.433461976866;3668.229671768932;3771.4908487354132;3782.924341513182;3827.75119617224;1060.7931453366596;1081.9404932728696;1094.578587243917;1096.0792933935531;1110.639042311252;12242.81635775464;12506.374681265992;12595.992320614421;12692.936535317356;12700.936495317465;5090.77091530882;5108.66793658411;5142.537171654569;5208.192730126761;5219.451957544479;10665.146788256921;10679.145668346513;10684.679459616069;10686.091682206945;10726.570937162582;5744.569157313134;5780.075187969988;5794.768209271666;5853.268341457318;5881.5000724938;4636.675432719677;5082;5150.948490515047;5153.639245252872;5244;4234;4303.548127446573;4360.71655342408;4398.164348773723;4433.046894917544;1411.6682579593787;1418.191630770451;1420.9076410033315;1428.314409083625;1440.042371822747;822.3996482567759;948.4688574398359;986.8717066781272;995.4375777685584;1003.307717674802;5196.350456192976;6175.567710260329;6293.527985401113;6351.174347334817;6355.3644635537;470.6775858536913;476.9713817170981;482.6862539349451;484.4356324881544;488.58470300244505;4022.4770779799023;4055.655269302142;4134.152498737752;4141.399497072907;4219.894502637398;11541.538338466535;11728.824067638992;11792.823107653392;11898.583549575724;11900.345480998629;11302.208845380745;11527.423628818693;11647;11730.589429369931;11742.29546227212;8587.871181932276;8889.19997200255;8920.197182253629;8952.194302512806;8959.328050396247;6135.8466038347615;6162.106494558354;6162.815115546541;6230.43926046658;6291.087792270004;10101.444420556645;10295.279330446796;10313.381197128196;10322.535485903003;10339.534720937425;10300.690979270634;10460.058594726512;10462.94768526183;10670.679879603624;10709.892901070889;7002.509824312249;7837.647305871364;7914.485558438683;8003.719869804529;8136.837263254583;8478.915210847812;8689.913100869164;8711.214201088635;8752.781180470285;8763.824723505622;7588.696452141852;7764.456488045783;7804.609769511615;7846.80382990407;7861.685532578633;7580.128285247267;7612.619369031416;7617.085949686073;7720.613969301625;7774.650140743794;7407.11114666222;7425.888611670937;7436.96281518589;7446.478746487694;7454.739084132029;4441.156180325857;5014.674046186986;5078.873028174326;5194.922076168785;5246.31797866275;5205.973970130125;5208.479152084913;5257.842264732064;5267.104592219409;5276.287701160294 04:20:29 INFO - PROCESS | 2366 | |4;prototype.html;329.7790480378146;341.6651681352275;341.76076746277613;347.33485375505893;349.86705052080214;5831.9416805831925;5975.641461512307;6963.791086267413;7018.122734658168;7038.648067596625;5495.313085864267;6892.310768923106;6900.689468973896;6904.654767261642;6925.961105834127;3728.9440658390145;4651.604613607848;4870.293807397934;5069.112905241586;5104.770285337168;5065.366829146356;5112.590992720573;5134.589232861362;5136.203888397305;5140.254663073871;5070.264811602316;5075.568576670969;5082.949170508303;5083.84748457545;5087.313212716273;5078.21287700407;5081.390233172025;5084.669496482717;5106.8212612558755;5137.845864624067;4384.079343337903;4390.8902277443;4391.01202229499;4409.713368631029;4427.446569178853;6386.201724784402;6600.900986485207;6653.301403352675;6726.260111387744;6743.527953043289;5933.050711886121;5969.37321581232;5970.791022314198;5975.402459754033;5977.402259774031;7424.220456852061;7433.479656424052;7439.925600743977;7474.177840437547;7475.588842613654;4742.146413645542;4751.453582837983;4759.619230461555;4769.809207631691;4788.042391521675;6295.36320556654;7094.822629434254;7880.133185349607;7882.921170788333;7919.683212671486;4734.384530011076;4736.976315118402;4764.475907650156;4766.785494652749;4786.521347865186;4878.292647566083;4882.438519570223;4883.731394773322;4889.706617602884;4905.460399356068;5812.7674893003805;5915.911261331084;5917.230760001258;5923;5935;7409.962950185214;7412.629368531552;7432.554046757212;7487.8502429951095;7490.775276741707;1629.6985057764352;1673.8493535581856;1700.6768713944311;1701.8468337849406;1702.0213377308098;1061.2836335473523;1063.4204358624568;1075.3332933581073;1075.693427373195;1082.3451811653993;6920.238773734885;6990.860182796316;6994.370506654425;7016.158061032709;7089;7296.635168241567;7521.435892308099;7629.809254768564;7641.808954776064;7652.387808975269;6989.965050174818;7028.92971070293;7052.541584796972;7056.188538318056;7059.82350441243;4007.91984160321;4055.2092341993616;4055.47278853753;4056.0873803394;4060.4773210046233;8093.150219226896;8140.674373025131;8152.307053900485;8159.79600509992;8171.673133074611;7693.615319234128;7850.921490785133;7953.403494737918;7962.482438641469;7991.480553763987;8054.5569993650915;8113.066997295268;8116.34764356054;8158.469699469515;8171.795705107301;6189.690515474298;7675.577843218676;7680.155182929985;7692.692292308245;7695.961520192363;7424.851502970018;7567.621618919142;7569.053868266466;7570.697172113054;7585.772426827204;6179.3820617937845;8155.632996515053;8181.509109453452;8213.671453141807;8215.055268644182;3742.569604495518;4189.80590531697;4751.429828420612;4837.806487740451;4866.197077482176;7551.697932082655;7728.149903510497;7751;7771.650275737492;7814.921850781419;6097.939020609914;7198.928010719826;7429.405647548291;7464.925350746423;7479.850402991801;7432.739854105081;7442.776716698508;7472.813179670552;7495.662695178839;7505.6997720090585;5820.563457740602;6038.124471951454;7102.325279098477;7218.169910460154;7310.415166786751;7472.29013243741;7474.887876681745;7480.438967077382;7483.727766279637;7493.850122997618;7012.123484564429;7151.141862976268;7187.712491500281;7271.091113610799;7369.299916507923 04:20:29 INFO - PROCESS | 2366 | |5;yui.html;677.2211956250311;710.8116349167472;716.9426445884329;745.880659094545;754.1478129713427;15573;15789.684206315882;15796.921015394935;15810.4466343678;15825.892187546862;15674.686506269867;15919.363225470966;15940.52178434646;15969.281382337793;15978.201089945514;765.1736124985002;939.9060093990597;951.8477043673014;963.2679163835501;963.3256720295786;933.869258303838;958.942463452195;976.9658061967832;980.4264505264393;983.1348413396202;1023.9488025598728;1035.7100011996615;1036.2228328753436;1037.419045334615;1039.5685790396976;989.9554520046615;1003.3177439341245;1005.316384858296;1021.3361315145141;1024.073213741565;660.633348491587;720.2077714514045;748.2928632442345;754.0348354106752;756.7767508584981;15498.61253468661;15530.456434024754;15580.844191558166;16090.195490225442;16134.951228170132;13362.198268103848;13388.665283367896;13395.732085358239;13426.462941482328;13444.395002224923;10305.536250868654;10331.793364132674;10338.172946164288;10373.740656483573;10699;3545.7872527648424;3558.62634423387;3593.957752251844;3650.945235821465;3829.157585331223;82674.17325826726;89915;90049.19901601996;90122.19755604917;91739;9886.653967111117;9907.950460247797;9918.900810991941;9921;10190.43952582615;22562.661560076613;23597.528049438915;23669.52660946806;23713.40716482102;23752.762472375056;7567.848643027219;7662.770116896502;7735.303822655988;7746.767596972099;7821.765347039598;4063.878083657495;4159.980804702806;4186.309258972296;4191.308434108338;4201.075763332123;3737.9626203738158;3742.73800833939;3815.198808250243;3819.312523745697;3827.27281816454;600.5315853634172;636.462189449914;663.9502037347219;668.9363911380927;682.1984168601873;487.2885587042886;523.1289902312607;567.5856624664018;571.4913726783167;607.2439812433461;8155.225253600898;8269.21442462965;8277.95861020691;8377.539235342114;8484.939382577179;524.8871492629027;584.8391692284656;588.4233451217831;597.489146779506;605.5458406195354;3755.7183211259266;3903.316919539069;3915.7454765440157;3941.586133456003;4090.427340172378;99480;100197.99802001887;100805;102624;103217.48391258146;77783.61108194536;78003.60998195087;78956.6052169747;79993.40013199704;83838;71632.2836771636;71981.64009180025;72383.63808180926;73010.63494682492;73284;8444.746657600283;8593.92575928009;8627.654893804178;8651.394402391772;8715.215630593277;49118.50881491282;50067.49932500628;50303.74848125882;50373.49626503688;50536;58297;70096;70530.64734676294;70583;72211.63894180706;10819.837702434626;11149.832752508557;11175.72060698489;11205.215634905479;11498.25261358009;11914.523419063487;11947.163698541019;11962.282263064244;12001.699957501132;12154.75690486203;11119.722006949567;11315.717107072389;11567.479463423997;11603.825942611036;11652.41737913084;10990.780184396428;11113;11273.549058037916;11340.546378144782;11592.362420066976;11104.774844913074;11143.777124457627;11170.218084734315;11460.94269528647;11825;9621.972594009168;9710.6115755369;9899.455529945923;9996.700098997042;10158.13655839262;9432.386894851812;9456.95973442907;9516.762080948032;9527.666531671359;9757.56090975922 04:20:29 INFO - PROCESS | 2366 | __end_tp_report 04:20:29 INFO - PROCESS | 2366 | __start_cc_report 04:20:29 INFO - PROCESS | 2366 | _x_x_mozilla_cycle_collect,400 04:20:29 INFO - PROCESS | 2366 | __end_cc_report 04:20:29 INFO - PROCESS | 2366 | __startTimestamp1469618429137__endTimestamp 04:20:29 INFO - PROCESS | 2366 | 04:20:29 INFO - PROCESS | 2366 | ------- Summary: start ------- 04:20:29 INFO - PROCESS | 2366 | Number of tests: 6 04:20:29 INFO - PROCESS | 2366 | 04:20:29 INFO - PROCESS | 2366 | [#0] dojo.html Cycles:165 Average:5977.90 Median:6254.62 stddev:711.86 (11.4%) stddev-sans-first:676.70 04:20:29 INFO - PROCESS | 2366 | Values: 3077.6 3656.9 3688.2 3714.8 3728.0 4853.0 6042.9 6075.8 6121.8 6150.8 6027.8 6059.7 6121.3 6122.7 6123.3 4376.6 4537.5 5444.3 5513.9 5565.7 4326.4 5462.1 5524.5 5563.5 5617.2 5540.5 5541.9 5581.0 5593.4 5608.6 4581.5 5468.6 5533.9 5540.0 5619.1 5302.3 5373.0 5430.6 5493.1 5544.9 4920.8 5861.0 5941.5 6027.8 6085.1 6351.4 6462.3 6474.7 6478.3 6485.1 6376.9 6444.3 6446.5 6464.2 6483.8 6061.4 6144.7 6163.3 6172.9 6187.9 6629.3 6643.2 6663.6 6674.1 6695.5 6280.6 6305.3 6336.6 6396.6 6407.4 6439.6 6466.7 6481.6 6489.9 6505.8 6262.8 6365.4 6386.2 6396.5 6403.3 6331.3 6366.0 6400.1 6404.1 6431.7 5054.0 5110.5 5136.2 5155.0 5164.4 4512.3 4530.7 4628.7 4643.2 4656.3 6109.4 6136.8 6159.4 6253.5 6275.0 6452.5 6480.4 6501.0 6532.0 6532.9 6135.6 6145.2 6258.6 6272.1 6288.9 5606.2 5659.9 5660.8 5677.7 5725.9 6733.8 6749.8 6774.8 6786.3 6805.7 6369.1 6467.8 6471.0 6477.0 6487.4 6751.3 6798.9 6818.2 6824.8 6835.5 6375.4 6398.5 6398.6 6423.6 6451.1 6296.8 6453.8 6457.1 6481.8 6526.2 6254.6 6323.6 6323.6 6336.4 6390.0 5845.8 6304.7 6319.7 6326.9 6333.7 4943.4 6128.4 6172.1 6220.6 6235.4 5183.9 6302.8 6311.0 6320.6 6331.0 6151.4 6188.5 6237.5 6253.8 6299.7 04:20:29 INFO - PROCESS | 2366 | 04:20:29 INFO - PROCESS | 2366 | [#1] ext.html Cycles:180 Average:71884.63 Median:19891.42 stddev:160869.55 (808.7%) stddev-sans-first:161231.58 04:20:29 INFO - PROCESS | 2366 | Values: 512.5 527.7 545.7 598.9 608.9 33909.8 42149.6 42172.7 42202.4 42231.6 33266.2 42602.6 43183.4 43235.4 43260.0 9716.8 9907.9 9914.0 9984.6 10027.2 9806.7 9937.9 10020.7 10031.7 10085.5 10074.5 10097.6 10139.5 10143.0 10147.3 10013.6 10040.3 10089.4 10097.4 10123.2 9863.4 9929.6 9998.0 10003.7 10006.9 41924.8 42381.4 42442.6 42551.0 42678.8 2835.3 3171.0 3196.8 3255.6 3394.5 28893.9 29037.3 29656.6 30251.4 30954.7 2828.7 2832.4 2833.4 2888.7 2899.4 446104.0 450147.0 453608.7 454123.0 454301.0 39154.2 40056.6 73687.9 74316.6 74327.3 39634.8 39723.4 39822.6 40108.6 40111.8 16105.1 16252.5 16300.0 16301.8 16337.8 13430.8 13472.8 13531.3 13548.7 13559.5 7532.5 8791.3 9008.0 9050.0 9076.4 3743.4 3782.4 3789.8 3790.7 3792.0 981.3 1078.3 1107.5 1131.8 1141.5 31558.4 31568.0 31588.7 32124.0 32203.8 1118.3 1133.6 1151.2 1172.1 1189.2 15763.3 16193.4 16458.0 16630.8 16697.8 635798.0 736980.0 741996.0 750717.0 755086.0 66231.7 66565.0 67150.0 67390.0 67603.7 1326.8 1520.3 1525.0 1530.8 1531.2 31672.7 32744.0 32747.9 33163.0 33317.7 58286.7 58433.0 58845.0 58875.0 59185.8 590102.0 590282.0 591195.0 591673.0 592142.0 29010.7 29494.1 29956.1 30027.5 30195.2 48905.3 49343.8 50852.2 50953.0 51080.7 32318.0 34381.3 36039.5 40572.0 41523.7 40385.6 40496.8 40784.8 40893.6 40927.6 35089.9 40044.6 40051.8 40468.8 41341.4 32145.0 33917.5 34230.5 35224.6 35288.0 26334.5 26549.6 26589.9 26711.0 26957.9 04:20:29 INFO - PROCESS | 2366 | 04:20:29 INFO - PROCESS | 2366 | [#2] jquery.html Cycles:180 Average:37753.58 Median:11888.24 stddev:114378.62 (962.1%) stddev-sans-first:114665.02 04:20:29 INFO - PROCESS | 2366 | Values: 359.6 424.1 424.3 435.0 439.2 19683.2 20761.3 20866.5 21598.8 23052.3 12283.4 12609.0 15783.7 21095.4 21387.9 5447.4 5485.6 5734.2 5772.8 5773.6 5503.8 5566.6 5643.8 5654.1 5669.6 5480.9 5620.6 5632.5 5668.6 5673.3 5636.6 5683.3 5683.7 5698.9 5709.3 5506.2 5561.1 5577.6 5580.7 5591.2 14180.4 14254.8 14585.7 14675.7 16964.9 2146.7 2187.6 2465.0 2493.4 2674.2 10805.8 10874.8 13867.9 14565.4 15735.4 1776.2 1805.4 1809.6 1821.0 1902.3 98992.0 122720.0 125865.0 127396.7 130150.0 8920.5 9853.0 11748.1 12238.8 12262.6 12948.7 14442.8 15587.2 15815.0 15902.7 8849.0 9198.8 9278.4 9285.7 9324.8 9239.8 9249.6 9250.9 9252.8 9304.3 3978.5 4935.9 4946.3 4957.6 4981.0 2066.5 2121.7 2131.5 2177.7 2181.4 939.0 978.4 1034.0 1044.6 1062.4 17251.7 18115.4 19783.9 20515.7 22330.4 999.2 1004.2 1015.1 1050.8 1094.6 11433.4 11740.5 11763.8 11843.5 11882.9 652428.7 687374.0 688422.0 699801.0 706206.0 125032.4 135583.3 139178.0 148656.0 152565.0 1008.6 1025.9 1034.1 1038.6 1070.3 19039.8 19549.2 19667.8 19803.2 19969.0 53900.5 55444.0 56168.6 56517.8 56609.9 77854.2 79451.8 80258.0 80341.6 82006.0 6622.8 8582.9 8749.9 8799.9 8943.9 12312.4 12907.7 13051.3 13346.3 13357.7 5705.7 6898.8 11533.8 11637.4 11749.4 6078.7 6996.8 11455.5 11480.6 11656.8 9335.0 11247.9 11866.7 11878.9 12260.8 8478.5 8583.2 8677.6 8800.9 9046.8 10256.3 10418.8 10869.5 11200.9 12059.8 04:20:29 INFO - PROCESS | 2366 | 04:20:29 INFO - PROCESS | 2366 | [#3] mootools.html Cycles:180 Average:6053.82 Median:483.56 stddev:3426.45 (708.6%) stddev-sans-first:3419.75 04:20:29 INFO - PROCESS | 2366 | Values: 1605.6 1647.1 1703.9 2064.7 2069.5 8509.8 9208.2 9322.0 9527.6 9535.5 7830.6 9334.4 9458.8 9480.4 9492.8 2592.5 2610.5 2613.8 2617.7 2619.8 2555.1 2613.9 2616.7 2624.2 2635.7 2001.7 2327.7 2573.5 2595.9 2615.5 2265.5 2503.1 2592.5 2606.0 2618.4 2569.7 2601.6 2601.9 2608.5 2638.2 8157.0 9482.3 9502.0 9558.9 9586.8 4892.6 5652.8 5715.9 5866.9 5890.1 3147.4 3668.2 3771.5 3782.9 3827.8 1060.8 1081.9 1094.6 1096.1 1110.6 12242.8 12506.4 12596.0 12692.9 12700.9 5090.8 5108.7 5142.5 5208.2 5219.5 10665.1 10679.1 10684.7 10686.1 10726.6 5744.6 5780.1 5794.8 5853.3 5881.5 4636.7 5082.0 5150.9 5153.6 5244.0 4234.0 4303.5 4360.7 4398.2 4433.0 1411.7 1418.2 1420.9 1428.3 1440.0 822.4 948.5 986.9 995.4 1003.3 5196.4 6175.6 6293.5 6351.2 6355.4 470.7 477.0 482.7 484.4 488.6 4022.5 4055.7 4134.2 4141.4 4219.9 11541.5 11728.8 11792.8 11898.6 11900.3 11302.2 11527.4 11647.0 11730.6 11742.3 8587.9 8889.2 8920.2 8952.2 8959.3 6135.8 6162.1 6162.8 6230.4 6291.1 10101.4 10295.3 10313.4 10322.5 10339.5 10300.7 10460.1 10462.9 10670.7 10709.9 7002.5 7837.6 7914.5 8003.7 8136.8 8478.9 8689.9 8711.2 8752.8 8763.8 7588.7 7764.5 7804.6 7846.8 7861.7 7580.1 7612.6 7617.1 7720.6 7774.7 7407.1 7425.9 7437.0 7446.5 7454.7 4441.2 5014.7 5078.9 5194.9 5246.3 5206.0 5208.5 5257.8 5267.1 5276.3 04:20:29 INFO - PROCESS | 2366 | 04:20:29 INFO - PROCESS | 2366 | [#4] prototype.html Cycles:180 Average:6015.73 Median:6902.67 stddev:1962.31 (28.4%) stddev-sans-first:1920.85 04:20:29 INFO - PROCESS | 2366 | Values: 329.8 341.7 341.8 347.3 349.9 5831.9 5975.6 6963.8 7018.1 7038.6 5495.3 6892.3 6900.7 6904.7 6926.0 3728.9 4651.6 4870.3 5069.1 5104.8 5065.4 5112.6 5134.6 5136.2 5140.3 5070.3 5075.6 5082.9 5083.8 5087.3 5078.2 5081.4 5084.7 5106.8 5137.8 4384.1 4390.9 4391.0 4409.7 4427.4 6386.2 6600.9 6653.3 6726.3 6743.5 5933.1 5969.4 5970.8 5975.4 5977.4 7424.2 7433.5 7439.9 7474.2 7475.6 4742.1 4751.5 4759.6 4769.8 4788.0 6295.4 7094.8 7880.1 7882.9 7919.7 4734.4 4737.0 4764.5 4766.8 4786.5 4878.3 4882.4 4883.7 4889.7 4905.5 5812.8 5915.9 5917.2 5923.0 5935.0 7410.0 7412.6 7432.6 7487.9 7490.8 1629.7 1673.8 1700.7 1701.8 1702.0 1061.3 1063.4 1075.3 1075.7 1082.3 6920.2 6990.9 6994.4 7016.2 7089.0 7296.6 7521.4 7629.8 7641.8 7652.4 6990.0 7028.9 7052.5 7056.2 7059.8 4007.9 4055.2 4055.5 4056.1 4060.5 8093.2 8140.7 8152.3 8159.8 8171.7 7693.6 7850.9 7953.4 7962.5 7991.5 8054.6 8113.1 8116.3 8158.5 8171.8 6189.7 7675.6 7680.2 7692.7 7696.0 7424.9 7567.6 7569.1 7570.7 7585.8 6179.4 8155.6 8181.5 8213.7 8215.1 3742.6 4189.8 4751.4 4837.8 4866.2 7551.7 7728.1 7751.0 7771.7 7814.9 6097.9 7198.9 7429.4 7464.9 7479.9 7432.7 7442.8 7472.8 7495.7 7505.7 5820.6 6038.1 7102.3 7218.2 7310.4 7472.3 7474.9 7480.4 7483.7 7493.9 7012.1 7151.1 7187.7 7271.1 7369.3 04:20:29 INFO - PROCESS | 2366 | 04:20:29 INFO - PROCESS | 2366 | [#5] yui.html Cycles:180 Average:19148.56 Median:24802.90 stddev:27250.80 (109.9%) stddev-sans-first:27291.95 04:20:29 INFO - PROCESS | 2366 | Values: 677.2 710.8 716.9 745.9 754.1 15573.0 15789.7 15796.9 15810.4 15825.9 15674.7 15919.4 15940.5 15969.3 15978.2 765.2 939.9 951.8 963.3 963.3 933.9 958.9 977.0 980.4 983.1 1023.9 1035.7 1036.2 1037.4 1039.6 990.0 1003.3 1005.3 1021.3 1024.1 660.6 720.2 748.3 754.0 756.8 15498.6 15530.5 15580.8 16090.2 16135.0 13362.2 13388.7 13395.7 13426.5 13444.4 10305.5 10331.8 10338.2 10373.7 10699.0 3545.8 3558.6 3594.0 3650.9 3829.2 82674.2 89915.0 90049.2 90122.2 91739.0 9886.7 9908.0 9918.9 9921.0 10190.4 22562.7 23597.5 23669.5 23713.4 23752.8 7567.8 7662.8 7735.3 7746.8 7821.8 4063.9 4160.0 4186.3 4191.3 4201.1 3738.0 3742.7 3815.2 3819.3 3827.3 600.5 636.5 664.0 668.9 682.2 487.3 523.1 567.6 571.5 607.2 8155.2 8269.2 8278.0 8377.5 8484.9 524.9 584.8 588.4 597.5 605.5 3755.7 3903.3 3915.7 3941.6 4090.4 99480.0 100198.0 100805.0 102624.0 103217.5 77783.6 78003.6 78956.6 79993.4 83838.0 71632.3 71981.6 72383.6 73010.6 73284.0 8444.7 8593.9 8627.7 8651.4 8715.2 49118.5 50067.5 50303.7 50373.5 50536.0 58297.0 70096.0 70530.6 70583.0 72211.6 10819.8 11149.8 11175.7 11205.2 11498.3 11914.5 11947.2 11962.3 12001.7 12154.8 11119.7 11315.7 11567.5 11603.8 11652.4 10990.8 11113.0 11273.5 11340.5 11592.4 11104.8 11143.8 11170.2 11460.9 11825.0 9622.0 9710.6 9899.5 9996.7 10158.1 9432.4 9457.0 9516.8 9527.7 9757.6 04:20:29 INFO - PROCESS | 2366 | -------- Summary: end -------- 04:20:29 INFO - PROCESS | 2366 | 04:20:29 INFO - TEST-INFO | 2366: exit 0 04:20:29 INFO - TEST-OK | dromaeo_css | took 1110531ms 04:20:29 INFO - TEST-START | kraken 04:20:29 INFO - operating with platform_type : mac_ 04:20:29 INFO - Initialising browser for kraken test... 04:20:29 INFO - TEST-INFO | started process 2370 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/tmp5Iudk1/profile http://localhost:49826/getInfo.html) 04:20:32 INFO - PROCESS | 2370 | __metrics Screen width/height:1600/1200 04:20:32 INFO - PROCESS | 2370 | colorDepth:24 04:20:32 INFO - PROCESS | 2370 | Browser inner width/height: 1024/689 04:20:32 INFO - PROCESS | 2370 | __metrics 04:20:32 ERROR - PROCESS | 2370 | JavaScript error: chrome://browser/content/tabbrowser.xml, line 2938: TypeError: this.tabs is undefined 04:20:32 INFO - TEST-INFO | 2370: exit 0 04:20:32 INFO - Browser initialized. 04:20:32 INFO - Running cycle 1/1 for kraken test... 04:20:32 INFO - TEST-INFO | started process 2374 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/tmp5Iudk1/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:20:44 INFO - PROCESS | 2374 | RSS: Main: 171266048 04:20:44 INFO - PROCESS | 2374 | 04:20:47 INFO - PROCESS | 2374 | Cycle 1(1): loaded http://localhost:49826/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49826/tests/kraken/driver.html?testName=audio-beat-detection) 04:20:48 INFO - PROCESS | 2374 | RSS: Main: 183488512 04:20:48 INFO - PROCESS | 2374 | 04:20:51 INFO - PROCESS | 2374 | Cycle 1(1): loaded http://localhost:49826/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49826/tests/kraken/driver.html?testName=audio-dft) 04:20:51 INFO - PROCESS | 2374 | RSS: Main: 192151552 04:20:51 INFO - PROCESS | 2374 | 04:20:54 INFO - PROCESS | 2374 | Cycle 1(1): loaded http://localhost:49826/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49826/tests/kraken/driver.html?testName=audio-fft) 04:20:55 INFO - PROCESS | 2374 | RSS: Main: 195633152 04:20:55 INFO - PROCESS | 2374 | 04:20:57 INFO - PROCESS | 2374 | Cycle 1(1): loaded http://localhost:49826/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49826/tests/kraken/driver.html?testName=audio-oscillator) 04:20:58 INFO - PROCESS | 2374 | RSS: Main: 196837376 04:20:58 INFO - PROCESS | 2374 | 04:21:00 INFO - PROCESS | 2374 | Cycle 1(1): loaded http://localhost:49826/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49826/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:21:00 INFO - PROCESS | 2374 | RSS: Main: 197111808 04:21:00 INFO - PROCESS | 2374 | 04:21:03 INFO - PROCESS | 2374 | Cycle 1(1): loaded http://localhost:49826/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49826/tests/kraken/driver.html?testName=imaging-darkroom) 04:21:04 INFO - PROCESS | 2374 | RSS: Main: 197791744 04:21:04 INFO - PROCESS | 2374 | 04:21:07 INFO - PROCESS | 2374 | Cycle 1(1): loaded http://localhost:49826/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49826/tests/kraken/driver.html?testName=imaging-desaturate) 04:21:07 INFO - PROCESS | 2374 | RSS: Main: 197570560 04:21:07 INFO - PROCESS | 2374 | 04:21:10 INFO - PROCESS | 2374 | Cycle 1(1): loaded http://localhost:49826/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49826/tests/kraken/driver.html?testName=json-parse-financial) 04:21:11 INFO - PROCESS | 2374 | RSS: Main: 197992448 04:21:11 INFO - PROCESS | 2374 | 04:21:12 INFO - PROCESS | 2374 | Cycle 1(1): loaded http://localhost:49826/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49826/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:21:13 INFO - PROCESS | 2374 | RSS: Main: 197324800 04:21:13 INFO - PROCESS | 2374 | 04:21:15 INFO - PROCESS | 2374 | Cycle 1(1): loaded http://localhost:49826/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49826/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:21:15 INFO - PROCESS | 2374 | RSS: Main: 197447680 04:21:15 INFO - PROCESS | 2374 | 04:21:17 INFO - PROCESS | 2374 | Cycle 1(1): loaded http://localhost:49826/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49826/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:21:18 INFO - PROCESS | 2374 | RSS: Main: 197844992 04:21:18 INFO - PROCESS | 2374 | 04:21:21 INFO - PROCESS | 2374 | Cycle 1(1): loaded http://localhost:49826/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:21:21 INFO - PROCESS | 2374 | RSS: Main: 198586368 04:21:21 INFO - PROCESS | 2374 | 04:21:24 INFO - PROCESS | 2374 | Cycle 1(1): loaded http://localhost:49826/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:21:25 INFO - PROCESS | 2374 | RSS: Main: 198062080 04:21:25 INFO - PROCESS | 2374 | 04:21:27 INFO - PROCESS | 2374 | Cycle 1(1): loaded http://localhost:49826/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49826/tests/kraken/driver.html?testName=ai-astar) 04:21:27 INFO - PROCESS | 2374 | RSS: Main: 199835648 04:21:27 INFO - PROCESS | 2374 | 04:21:27 INFO - PROCESS | 2374 | __start_tp_report 04:21:27 INFO - PROCESS | 2374 | _x_x_mozilla_page_load 04:21:27 INFO - PROCESS | 2374 | _x_x_mozilla_page_load_details 04:21:27 INFO - PROCESS | 2374 | |i|pagename|runs| 04:21:27 INFO - PROCESS | 2374 | |0;ai-astar;116;122;142;134;119;117;106;115;116;116 04:21:27 INFO - PROCESS | 2374 | |1;audio-beat-detection;154;117;162;143;152;173;157;168;153;118 04:21:27 INFO - PROCESS | 2374 | |2;audio-dft;203;198;195;200;197;197;201;201;198;198 04:21:27 INFO - PROCESS | 2374 | |3;audio-fft;64;70;80;149;83;65;56;67;123;57 04:21:27 INFO - PROCESS | 2374 | |4;audio-oscillator;76;80;109;78;104;130;159;111;79;117 04:21:27 INFO - PROCESS | 2374 | |5;imaging-gaussian-blur;89;93;88;87;88;85;89;85;88;86 04:21:27 INFO - PROCESS | 2374 | |6;imaging-darkroom;94;93;95;93;94;93;94;95;93;95 04:21:27 INFO - PROCESS | 2374 | |7;imaging-desaturate;90;93;90;92;90;102;127;94;90;91 04:21:27 INFO - PROCESS | 2374 | |8;json-parse-financial;58;62;63;64;64;65;65;78;62;59 04:21:27 INFO - PROCESS | 2374 | |9;json-stringify-tinderbox;63;68;87;56;61;90;110;100;60;80 04:21:27 INFO - PROCESS | 2374 | |10;stanford-crypto-aes;82;81;78;81;82;80;81;80;84;83 04:21:27 INFO - PROCESS | 2374 | |11;stanford-crypto-ccm;146;145;149;129;123;123;124;162;134;141 04:21:27 INFO - PROCESS | 2374 | |12;stanford-crypto-pbkdf2;167;163;162;167;167;164;162;163;166;164 04:21:27 INFO - PROCESS | 2374 | |13;stanford-crypto-sha256-iterative;66;67;98;95;99;75;95;73;67;66 04:21:27 INFO - PROCESS | 2374 | __end_tp_report 04:21:27 INFO - PROCESS | 2374 | __start_cc_report 04:21:27 INFO - PROCESS | 2374 | _x_x_mozilla_cycle_collect,1050 04:21:27 INFO - PROCESS | 2374 | __end_cc_report 04:21:27 INFO - PROCESS | 2374 | __startTimestamp1469618487331__endTimestamp 04:21:27 INFO - PROCESS | 2374 | 04:21:27 INFO - PROCESS | 2374 | ------- Summary: start ------- 04:21:27 INFO - PROCESS | 2374 | Number of tests: 14 04:21:27 INFO - PROCESS | 2374 | 04:21:27 INFO - PROCESS | 2374 | [#0] ai-astar Cycles:10 Average:120.30 Median:118.00 stddev:10.34 (8.8%) stddev-sans-first:10.85 04:21:27 INFO - PROCESS | 2374 | Values: 116.0 122.0 142.0 134.0 119.0 117.0 106.0 115.0 116.0 116.0 04:21:27 INFO - PROCESS | 2374 | 04:21:27 INFO - PROCESS | 2374 | [#1] audio-beat-detection Cycles:10 Average:149.70 Median:155.50 stddev:18.96 (12.2%) stddev-sans-first:20.05 04:21:27 INFO - PROCESS | 2374 | Values: 154.0 117.0 162.0 143.0 152.0 173.0 157.0 168.0 153.0 118.0 04:21:27 INFO - PROCESS | 2374 | 04:21:27 INFO - PROCESS | 2374 | [#2] audio-dft Cycles:10 Average:198.80 Median:199.00 stddev:2.39 (1.2%) stddev-sans-first:2.00 04:21:27 INFO - PROCESS | 2374 | Values: 203.0 198.0 195.0 200.0 197.0 197.0 201.0 201.0 198.0 198.0 04:21:27 INFO - PROCESS | 2374 | 04:21:27 INFO - PROCESS | 2374 | [#3] audio-fft Cycles:10 Average:81.40 Median:66.00 stddev:30.65 (46.4%) stddev-sans-first:31.86 04:21:27 INFO - PROCESS | 2374 | Values: 64.0 70.0 80.0 149.0 83.0 65.0 56.0 67.0 123.0 57.0 04:21:27 INFO - PROCESS | 2374 | 04:21:27 INFO - PROCESS | 2374 | [#4] audio-oscillator Cycles:10 Average:104.30 Median:117.50 stddev:27.09 (23.1%) stddev-sans-first:26.73 04:21:27 INFO - PROCESS | 2374 | Values: 76.0 80.0 109.0 78.0 104.0 130.0 159.0 111.0 79.0 117.0 04:21:27 INFO - PROCESS | 2374 | 04:21:27 INFO - PROCESS | 2374 | [#5] imaging-gaussian-blur Cycles:10 Average:87.80 Median:88.00 stddev:2.35 (2.7%) stddev-sans-first:2.45 04:21:27 INFO - PROCESS | 2374 | Values: 89.0 93.0 88.0 87.0 88.0 85.0 89.0 85.0 88.0 86.0 04:21:27 INFO - PROCESS | 2374 | 04:21:27 INFO - PROCESS | 2374 | [#6] imaging-darkroom Cycles:10 Average:93.90 Median:94.00 stddev:0.88 (0.9%) stddev-sans-first:0.93 04:21:27 INFO - PROCESS | 2374 | Values: 94.0 93.0 95.0 93.0 94.0 93.0 94.0 95.0 93.0 95.0 04:21:27 INFO - PROCESS | 2374 | 04:21:27 INFO - PROCESS | 2374 | [#7] imaging-desaturate Cycles:10 Average:95.90 Median:90.50 stddev:11.52 (12.7%) stddev-sans-first:12.02 04:21:27 INFO - PROCESS | 2374 | Values: 90.0 93.0 90.0 92.0 90.0 102.0 127.0 94.0 90.0 91.0 04:21:27 INFO - PROCESS | 2374 | 04:21:27 INFO - PROCESS | 2374 | [#8] json-parse-financial Cycles:10 Average:64.00 Median:64.00 stddev:5.46 (8.5%) stddev-sans-first:5.34 04:21:27 INFO - PROCESS | 2374 | Values: 58.0 62.0 63.0 64.0 64.0 65.0 65.0 78.0 62.0 59.0 04:21:27 INFO - PROCESS | 2374 | 04:21:27 INFO - PROCESS | 2374 | [#9] json-stringify-tinderbox Cycles:10 Average:77.50 Median:65.50 stddev:18.73 (28.6%) stddev-sans-first:19.11 04:21:27 INFO - PROCESS | 2374 | Values: 63.0 68.0 87.0 56.0 61.0 90.0 110.0 100.0 60.0 80.0 04:21:27 INFO - PROCESS | 2374 | 04:21:27 INFO - PROCESS | 2374 | [#10] stanford-crypto-aes Cycles:10 Average:81.20 Median:81.50 stddev:1.69 (2.1%) stddev-sans-first:1.76 04:21:27 INFO - PROCESS | 2374 | Values: 82.0 81.0 78.0 81.0 82.0 80.0 81.0 80.0 84.0 83.0 04:21:27 INFO - PROCESS | 2374 | 04:21:27 INFO - PROCESS | 2374 | [#11] stanford-crypto-ccm Cycles:10 Average:137.60 Median:143.00 stddev:13.17 (9.2%) stddev-sans-first:13.61 04:21:27 INFO - PROCESS | 2374 | Values: 146.0 145.0 149.0 129.0 123.0 123.0 124.0 162.0 134.0 141.0 04:21:27 INFO - PROCESS | 2374 | 04:21:27 INFO - PROCESS | 2374 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:164.50 Median:165.00 stddev:2.07 (1.3%) stddev-sans-first:1.99 04:21:27 INFO - PROCESS | 2374 | Values: 167.0 163.0 162.0 167.0 167.0 164.0 162.0 163.0 166.0 164.0 04:21:27 INFO - PROCESS | 2374 | 04:21:27 INFO - PROCESS | 2374 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:80.10 Median:85.00 stddev:14.68 (17.3%) stddev-sans-first:14.65 04:21:27 INFO - PROCESS | 2374 | Values: 66.0 67.0 98.0 95.0 99.0 75.0 95.0 73.0 67.0 66.0 04:21:27 INFO - PROCESS | 2374 | -------- Summary: end -------- 04:21:27 INFO - PROCESS | 2374 | 04:21:28 INFO - TEST-INFO | 2374: exit 0 04:21:28 INFO - TEST-OK | kraken | took 58395ms 04:21:28 INFO - SUITE-END | took 1168s 04:21:28 INFO - Completed test suite (00:19:29) 04:21:28 INFO - javascript benchmark 04:21:28 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3077.5537547055665, 3656.872009479668, 3688.170161713614, 3714.7585406948547, 3728.0, 4852.951470485303, 6042.9093563596525, 6075.817725468243, 6121.785737499183, 6150.7539698412065, 6027.849303767408, 6059.66671833049, 6121.265448146218, 6122.65301633641, 6123.295820980588, 4376.5623437656295, 4537.455505339364, 5444.265024221739, 5513.9448605514035, 5565.693886836222, 4326.43756311679, 5462.071447853855, 5524.530414914737, 5563.499285064343, 5617.185508101323, 5540.473655002768, 5541.889162216753, 5581.023320918823, 5593.412691667357, 5608.635438696492, 4581.496035436099, 5468.589855760833, 5533.861653458675, 5540.0, 5619.1009438490055, 5302.310699609065, 5373.0, 5430.56555475561, 5493.066178749622, 5544.86137846553, 4920.827771027997, 5861.003629383015, 5941.524678025748, 6027.758889644409, 6085.148079268906, 6351.364863513658, 6462.25684046336, 6474.708638111297, 6478.2873883872735, 6485.0596663484, 6376.936230637681, 6444.2911279759655, 6446.516511261627, 6464.191976003, 6483.805485835385, 6061.363556826514, 6144.701660918228, 6163.2604087509335, 6172.9074063889075, 6187.907181392283, 6629.303923088103, 6643.2028156620545, 6663.566868153554, 6674.098996635489, 6695.497837662195, 6280.623162610258, 6305.306416294204, 6336.58812177207, 6396.552241343062, 6407.359264073649, 6439.64581947988, 6466.6766661666725, 6481.643509606923, 6489.902651460232, 6505.772297969548, 6262.812115636538, 6365.427111559982, 6386.233651961795, 6396.456301214356, 6403.295637479967, 6331.3352098029045, 6365.968170159213, 6400.103985442041, 6404.103425520431, 6431.710573024225, 5053.9747301264, 5110.488951104934, 5136.2295655651205, 5155.0, 5164.354455693038, 4512.300593408027, 4530.728156310632, 4628.722276663411, 4643.187442197602, 4656.254999200111, 6109.435031337442, 6136.7948077883175, 6159.384061593894, 6253.499720022387, 6274.996000639967, 6452.483801295979, 6480.384363485461, 6500.967495162588, 6532.0, 6532.869342613121, 6135.569531795964, 6145.248604147886, 6258.593191442542, 6272.1219029335925, 6288.874222515616, 5606.1590761385305, 5659.943400566024, 5660.830175094754, 5677.744501497443, 5725.942740572625, 6733.797986060524, 6749.763758268437, 6774.796756097325, 6786.253512113663, 6805.727770889109, 6369.108324834434, 6467.838304042437, 6471.02934559801, 6477.0, 6487.416132548094, 6751.257361690308, 6798.8640227196165, 6818.249992500921, 6824.829379265558, 6835.453163746988, 6375.362463753588, 6398.488120950406, 6398.616083035033, 6423.550351475352, 6451.1290975717675, 6296.779612713533, 6453.838654033687, 6457.09600655918, 6481.837954050998, 6526.24948130952, 6254.6247225166635, 6323.588966717149, 6323.620582765049, 6336.366363363627, 6390.041493775785, 5845.795397161079, 6304.65324407162, 6319.652419116809, 6326.8734625306315, 6333.683315834282, 4943.406791184937, 6128.442013631005, 6172.074188871705, 6220.564560480723, 6235.407636274546, 5183.948160518497, 6302.842428939313, 6311.0217916223055, 6320.62076275425, 6331.0, 6151.354107818794, 6188.535859810442, 6237.5009999200865, 6253.78111766086, 6299.685015749103], "value": 5933.606381568001, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [512.5182328611105, 527.678116349027, 545.68623041751, 598.8562744941215, 608.8660494691168, 33909.830450847745, 42149.57850421499, 42172.73481795543, 42202.36696449548, 42231.577684223186, 33266.16834579137, 42602.573974260245, 43183.3522497162, 43235.35146972798, 43260.0, 9716.757081072978, 9907.851382229272, 9914.0, 9984.600615975389, 10027.247956403262, 9806.705798826046, 9937.850932235986, 10020.69937901864, 10031.74920626983, 10085.546150423212, 10074.496275186248, 10097.646582369618, 10139.543720532594, 10143.0, 10147.289689721723, 10013.599456021822, 10040.347377420481, 10089.394636321844, 10097.444640544767, 10123.240756943258, 9863.35888167274, 9929.602815887356, 9998.0, 10003.74990625233, 10006.9499652502, 41924.79037604823, 42381.364279535526, 42442.57557424417, 42551.0, 42678.78660606708, 2835.3478699899138, 3171.0, 3196.8081915085168, 3255.576775019256, 3394.4908263760385, 28893.855530722423, 29037.274068148254, 29656.555151672743, 30251.394972100654, 30954.690453095405, 2828.6605607327047, 2832.419354032439, 2833.4333133373407, 2888.6966868478926, 2899.362140329124, 446104.0, 450147.0, 453608.7319563381, 454123.0, 454301.0, 39154.21691566153, 40056.59943400587, 73687.89468157983, 74316.62841685866, 74327.25672743203, 39634.801825991264, 39723.40414893779, 39822.60177398189, 40108.59891401107, 40111.79944100319, 16105.114218718083, 16252.512424627044, 16300.043994720709, 16301.83698163027, 16337.836621633869, 13430.798538021938, 13472.797908031387, 13531.32343382827, 13548.661283467993, 13559.525416610371, 7532.548047117081, 8791.252743516872, 9007.954960225157, 9050.049744776836, 9076.41003334781, 3743.3903421529003, 3782.3759079751535, 3789.77261364319, 3790.711158206223, 3792.033031576985, 981.3326937682302, 1078.309881675728, 1107.4518113533852, 1131.7550694236274, 1141.452102990569, 31558.36883262322, 31568.0, 31588.684113158575, 32124.0, 32203.838980805416, 1118.3345909184022, 1133.5919069135105, 1151.228676786555, 1172.0799172649429, 1189.2270024484155, 15763.290651920692, 16193.433229836899, 16458.0, 16630.75053874193, 16697.83302166987, 635798.0, 736980.0, 741996.0, 750717.0, 755086.0, 66231.66884165548, 66565.0, 67150.0, 67390.0, 67603.66198169076, 1326.8076128961247, 1520.3386526860852, 1525.046845721424, 1530.8163020437396, 1531.1502116325546, 31672.683273166975, 32744.0, 32747.853825116006, 33163.0, 33317.666823331456, 58286.708566456895, 58433.0, 58845.0, 58875.0, 59185.81628367322, 590102.0, 590282.0, 591195.0, 591673.0, 592142.0, 29010.709892900803, 29494.11517654474, 29956.101316960525, 30027.549586756653, 30195.245118872204, 48905.266421004424, 49343.7532812348, 50852.23721644104, 50953.0, 51080.74459627678, 32318.030459086265, 34381.2809359526, 36039.459408109426, 40572.0, 41523.68491480587, 40385.59614403819, 40496.79751601223, 40784.79607601943, 40893.59106408898, 40927.59072409238, 35089.94730158099, 40044.59955400409, 40051.79974100111, 40468.797656011535, 41341.37987930243, 32145.0, 33917.49123763195, 34230.486542702376, 35224.64775352316, 35288.0, 26334.473310534064, 26549.60175597406, 26589.93640254368, 26711.0, 26957.865210673823], "value": 19647.019744686524, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.6349705049374, 424.06625786413974, 424.3126135660231, 434.952155262921, 439.1502442773234, 19683.21267149316, 20761.273355432582, 20866.47833804154, 21598.784012159875, 23052.308430747064, 12283.385830708474, 12609.0, 15783.684326313467, 21095.367138985817, 21387.893060534676, 5447.373552041507, 5485.588580856432, 5734.168545560891, 5772.797952071678, 5773.566982476331, 5503.752331145108, 5566.610337276392, 5643.774249030034, 5654.067078931971, 5669.603127781057, 5480.876420333842, 5620.57845661575, 5632.493075623193, 5668.57485688573, 5673.319201695782, 5636.633618814764, 5683.318001839764, 5683.687397193153, 5698.857528561778, 5709.286339207599, 5506.174073888908, 5561.110222364402, 5577.553795696375, 5580.665160090408, 5591.245181900432, 14180.361883715257, 14254.786178207336, 14585.70828583433, 14675.706485870329, 16964.915175424045, 2146.7209262795736, 2187.6171669957853, 2464.9753502464923, 2493.4389762303517, 2674.17100698784, 10805.783884322269, 10874.782504349947, 13867.890568754476, 14565.397806241304, 15735.44925927587, 1776.2184638759034, 1805.3681211575974, 1809.5566586186337, 1821.0483251344615, 1902.2771346888233, 98992.0, 122720.0, 125865.0, 127396.72603273942, 130150.0, 8920.464772113693, 9852.95073524642, 11748.060155187564, 12238.75522489563, 12262.632121036384, 12948.676283092998, 14442.783358249635, 15587.220638968232, 15814.97202681822, 15902.681946361008, 8849.0, 9198.770030749285, 9278.396904201205, 9285.72142835716, 9324.766880828034, 9239.815203695889, 9249.630014799333, 9250.90749092514, 9252.768680783034, 9304.348695591243, 3978.5026871641044, 4935.90128197434, 4946.282788995647, 4957.603391728653, 4981.028699403654, 2066.524699319165, 2121.7241758571595, 2131.541718530523, 2177.6951226828255, 2181.4328274648706, 938.9765255868658, 978.3640633588083, 1033.9689809305733, 1044.5717255925035, 1062.4103622489592, 17251.65496690059, 18115.365962191525, 19783.865343012607, 20515.692264616042, 22330.44173895633, 999.2263731875834, 1004.2417974429259, 1015.1016350529834, 1050.8318669012922, 1094.5567045346647, 11433.371164586028, 11740.471678774476, 11763.764724705457, 11843.46704398304, 11882.940585297018, 652428.7378563076, 687374.0, 688422.0, 699801.0, 706206.0, 125032.37483812522, 135583.32208339093, 139178.0, 148656.0, 152565.0, 1008.5763979128636, 1025.8717660292464, 1034.1468288661883, 1038.6053299746047, 1070.2775626452114, 19039.809601903802, 19549.218031279157, 19667.80332196717, 19803.207871684972, 19969.0, 53900.46099538954, 55444.0, 56168.5957851057, 56517.76116791339, 56609.86780264289, 77854.22145778696, 79451.80822287787, 80258.0, 80341.59829200816, 82006.0, 6622.8344291393105, 8582.871256931026, 8749.8687519686, 8799.868001979847, 8943.910560894568, 12312.384380781104, 12907.677308067374, 13051.347432628521, 13346.265955372548, 13357.66605834862, 5705.657660540381, 6898.758543450955, 11533.826992595286, 11637.359945202756, 11749.412529373327, 6078.7264573093435, 6996.775564276333, 11455.541778328774, 11480.598179063692, 11656.825147622623, 9334.953325233331, 11247.887521124683, 11866.703332416413, 11878.940605296919, 12260.754784904073, 8478.533680647624, 8583.18459746323, 8677.566121694017, 8800.855888734424, 9046.773830654287, 10256.333338332985, 10418.843717344398, 10869.456527173768, 11200.935911088434, 12059.81910271329], "value": 9644.989317957483, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1605.6307049378643, 1647.0694057857313, 1703.863690904727, 2064.7212626295445, 2069.5033192033916, 8509.829803403929, 9208.171264586186, 9322.0, 9527.618895244183, 9535.47554884481, 7830.56931868747, 9334.439933603971, 9458.81082378352, 9480.383775054617, 9492.762680932963, 2592.5463043967325, 2610.543154947886, 2613.751693589106, 2617.738226177386, 2619.7773189278932, 2555.080171138389, 2613.9346516337055, 2616.738326167387, 2624.173385383598, 2635.7364263573586, 2001.6697244954564, 2327.697399338084, 2573.523898078852, 2595.909143179989, 2615.5292047431453, 2265.478939843829, 2503.086373473678, 2592.5333439980795, 2606.0357667662993, 2618.358502166972, 2569.7301783312855, 2601.6357709920626, 2601.9349516262055, 2608.4522250327454, 2638.1557901471538, 8157.021157461143, 9482.288828337832, 9501.952490237505, 9558.852937647458, 9586.76033099171, 4892.556695774755, 5652.773889044474, 5715.857103572403, 5866.853328666774, 5890.145928840294, 3147.433461976866, 3668.229671768932, 3771.4908487354132, 3782.924341513182, 3827.75119617224, 1060.7931453366596, 1081.9404932728696, 1094.578587243917, 1096.0792933935531, 1110.639042311252, 12242.81635775464, 12506.374681265992, 12595.992320614421, 12692.936535317356, 12700.936495317465, 5090.77091530882, 5108.66793658411, 5142.537171654569, 5208.192730126761, 5219.451957544479, 10665.146788256921, 10679.145668346513, 10684.679459616069, 10686.091682206945, 10726.570937162582, 5744.569157313134, 5780.075187969988, 5794.768209271666, 5853.268341457318, 5881.5000724938, 4636.675432719677, 5082.0, 5150.948490515047, 5153.639245252872, 5244.0, 4234.0, 4303.548127446573, 4360.71655342408, 4398.164348773723, 4433.046894917544, 1411.6682579593787, 1418.191630770451, 1420.9076410033315, 1428.314409083625, 1440.042371822747, 822.3996482567759, 948.4688574398359, 986.8717066781272, 995.4375777685584, 1003.307717674802, 5196.350456192976, 6175.567710260329, 6293.527985401113, 6351.174347334817, 6355.3644635537, 470.6775858536913, 476.9713817170981, 482.6862539349451, 484.4356324881544, 488.58470300244505, 4022.4770779799023, 4055.655269302142, 4134.152498737752, 4141.399497072907, 4219.894502637398, 11541.538338466535, 11728.824067638992, 11792.823107653392, 11898.583549575724, 11900.345480998629, 11302.208845380745, 11527.423628818693, 11647.0, 11730.589429369931, 11742.29546227212, 8587.871181932276, 8889.19997200255, 8920.197182253629, 8952.194302512806, 8959.328050396247, 6135.8466038347615, 6162.106494558354, 6162.815115546541, 6230.43926046658, 6291.087792270004, 10101.444420556645, 10295.279330446796, 10313.381197128196, 10322.535485903003, 10339.534720937425, 10300.690979270634, 10460.058594726512, 10462.94768526183, 10670.679879603624, 10709.892901070889, 7002.509824312249, 7837.647305871364, 7914.485558438683, 8003.719869804529, 8136.837263254583, 8478.915210847812, 8689.913100869164, 8711.214201088635, 8752.781180470285, 8763.824723505622, 7588.696452141852, 7764.456488045783, 7804.609769511615, 7846.80382990407, 7861.685532578633, 7580.128285247267, 7612.619369031416, 7617.085949686073, 7720.613969301625, 7774.650140743794, 7407.11114666222, 7425.888611670937, 7436.96281518589, 7446.478746487694, 7454.739084132029, 4441.156180325857, 5014.674046186986, 5078.873028174326, 5194.922076168785, 5246.31797866275, 5205.973970130125, 5208.479152084913, 5257.842264732064, 5267.104592219409, 5276.287701160294], "value": 4790.005754482566, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [329.7790480378146, 341.6651681352275, 341.76076746277613, 347.33485375505893, 349.86705052080214, 5831.9416805831925, 5975.641461512307, 6963.791086267413, 7018.122734658168, 7038.648067596625, 5495.313085864267, 6892.310768923106, 6900.689468973896, 6904.654767261642, 6925.961105834127, 3728.9440658390145, 4651.604613607848, 4870.293807397934, 5069.112905241586, 5104.770285337168, 5065.366829146356, 5112.590992720573, 5134.589232861362, 5136.203888397305, 5140.254663073871, 5070.264811602316, 5075.568576670969, 5082.949170508303, 5083.84748457545, 5087.313212716273, 5078.21287700407, 5081.390233172025, 5084.669496482717, 5106.8212612558755, 5137.845864624067, 4384.079343337903, 4390.8902277443, 4391.01202229499, 4409.713368631029, 4427.446569178853, 6386.201724784402, 6600.900986485207, 6653.301403352675, 6726.260111387744, 6743.527953043289, 5933.050711886121, 5969.37321581232, 5970.791022314198, 5975.402459754033, 5977.402259774031, 7424.220456852061, 7433.479656424052, 7439.925600743977, 7474.177840437547, 7475.588842613654, 4742.146413645542, 4751.453582837983, 4759.619230461555, 4769.809207631691, 4788.042391521675, 6295.36320556654, 7094.822629434254, 7880.133185349607, 7882.921170788333, 7919.683212671486, 4734.384530011076, 4736.976315118402, 4764.475907650156, 4766.785494652749, 4786.521347865186, 4878.292647566083, 4882.438519570223, 4883.731394773322, 4889.706617602884, 4905.460399356068, 5812.7674893003805, 5915.911261331084, 5917.230760001258, 5923.0, 5935.0, 7409.962950185214, 7412.629368531552, 7432.554046757212, 7487.8502429951095, 7490.775276741707, 1629.6985057764352, 1673.8493535581856, 1700.6768713944311, 1701.8468337849406, 1702.0213377308098, 1061.2836335473523, 1063.4204358624568, 1075.3332933581073, 1075.693427373195, 1082.3451811653993, 6920.238773734885, 6990.860182796316, 6994.370506654425, 7016.158061032709, 7089.0, 7296.635168241567, 7521.435892308099, 7629.809254768564, 7641.808954776064, 7652.387808975269, 6989.965050174818, 7028.92971070293, 7052.541584796972, 7056.188538318056, 7059.82350441243, 4007.91984160321, 4055.2092341993616, 4055.47278853753, 4056.0873803394, 4060.4773210046233, 8093.150219226896, 8140.674373025131, 8152.307053900485, 8159.79600509992, 8171.673133074611, 7693.615319234128, 7850.921490785133, 7953.403494737918, 7962.482438641469, 7991.480553763987, 8054.5569993650915, 8113.066997295268, 8116.34764356054, 8158.469699469515, 8171.795705107301, 6189.690515474298, 7675.577843218676, 7680.155182929985, 7692.692292308245, 7695.961520192363, 7424.851502970018, 7567.621618919142, 7569.053868266466, 7570.697172113054, 7585.772426827204, 6179.3820617937845, 8155.632996515053, 8181.509109453452, 8213.671453141807, 8215.055268644182, 3742.569604495518, 4189.80590531697, 4751.429828420612, 4837.806487740451, 4866.197077482176, 7551.697932082655, 7728.149903510497, 7751.0, 7771.650275737492, 7814.921850781419, 6097.939020609914, 7198.928010719826, 7429.405647548291, 7464.925350746423, 7479.850402991801, 7432.739854105081, 7442.776716698508, 7472.813179670552, 7495.662695178839, 7505.6997720090585, 5820.563457740602, 6038.124471951454, 7102.325279098477, 7218.169910460154, 7310.415166786751, 7472.29013243741, 7474.887876681745, 7480.438967077382, 7483.727766279637, 7493.850122997618, 7012.123484564429, 7151.141862976268, 7187.712491500281, 7271.091113610799, 7369.299916507923], "value": 5359.210714744446, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [677.2211956250311, 710.8116349167472, 716.9426445884329, 745.880659094545, 754.1478129713427, 15573.0, 15789.684206315882, 15796.921015394935, 15810.4466343678, 15825.892187546862, 15674.686506269867, 15919.363225470966, 15940.52178434646, 15969.281382337793, 15978.201089945514, 765.1736124985002, 939.9060093990597, 951.8477043673014, 963.2679163835501, 963.3256720295786, 933.869258303838, 958.942463452195, 976.9658061967832, 980.4264505264393, 983.1348413396202, 1023.9488025598728, 1035.7100011996615, 1036.2228328753436, 1037.419045334615, 1039.5685790396976, 989.9554520046615, 1003.3177439341245, 1005.316384858296, 1021.3361315145141, 1024.073213741565, 660.633348491587, 720.2077714514045, 748.2928632442345, 754.0348354106752, 756.7767508584981, 15498.61253468661, 15530.456434024754, 15580.844191558166, 16090.195490225442, 16134.951228170132, 13362.198268103848, 13388.665283367896, 13395.732085358239, 13426.462941482328, 13444.395002224923, 10305.536250868654, 10331.793364132674, 10338.172946164288, 10373.740656483573, 10699.0, 3545.7872527648424, 3558.62634423387, 3593.957752251844, 3650.945235821465, 3829.157585331223, 82674.17325826726, 89915.0, 90049.19901601996, 90122.19755604917, 91739.0, 9886.653967111117, 9907.950460247797, 9918.900810991941, 9921.0, 10190.43952582615, 22562.661560076613, 23597.528049438915, 23669.52660946806, 23713.40716482102, 23752.762472375056, 7567.848643027219, 7662.770116896502, 7735.303822655988, 7746.767596972099, 7821.765347039598, 4063.878083657495, 4159.980804702806, 4186.309258972296, 4191.308434108338, 4201.075763332123, 3737.9626203738158, 3742.73800833939, 3815.198808250243, 3819.312523745697, 3827.27281816454, 600.5315853634172, 636.462189449914, 663.9502037347219, 668.9363911380927, 682.1984168601873, 487.2885587042886, 523.1289902312607, 567.5856624664018, 571.4913726783167, 607.2439812433461, 8155.225253600898, 8269.21442462965, 8277.95861020691, 8377.539235342114, 8484.939382577179, 524.8871492629027, 584.8391692284656, 588.4233451217831, 597.489146779506, 605.5458406195354, 3755.7183211259266, 3903.316919539069, 3915.7454765440157, 3941.586133456003, 4090.427340172378, 99480.0, 100197.99802001887, 100805.0, 102624.0, 103217.48391258146, 77783.61108194536, 78003.60998195087, 78956.6052169747, 79993.40013199704, 83838.0, 71632.2836771636, 71981.64009180025, 72383.63808180926, 73010.63494682492, 73284.0, 8444.746657600283, 8593.92575928009, 8627.654893804178, 8651.394402391772, 8715.215630593277, 49118.50881491282, 50067.49932500628, 50303.74848125882, 50373.49626503688, 50536.0, 58297.0, 70096.0, 70530.64734676294, 70583.0, 72211.63894180706, 10819.837702434626, 11149.832752508557, 11175.72060698489, 11205.215634905479, 11498.25261358009, 11914.523419063487, 11947.163698541019, 11962.282263064244, 12001.699957501132, 12154.75690486203, 11119.722006949567, 11315.717107072389, 11567.479463423997, 11603.825942611036, 11652.41737913084, 10990.780184396428, 11113.0, 11273.549058037916, 11340.546378144782, 11592.362420066976, 11104.774844913074, 11143.777124457627, 11170.218084734315, 11460.94269528647, 11825.0, 9621.972594009168, 9710.6115755369, 9899.455529945923, 9996.700098997042, 10158.13655839262, 9432.386894851812, 9456.95973442907, 9516.762080948032, 9527.666531671359, 9757.56090975922], "value": 7137.79064721837, "unit": "score"}], "name": "dromaeo_css", "value": 7685.260756080228, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 122.0, 142.0, 134.0, 119.0, 117.0, 106.0, 115.0, 116.0, 116.0], "value": 120.3, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [154.0, 117.0, 162.0, 143.0, 152.0, 173.0, 157.0, 168.0, 153.0, 118.0], "value": 149.7, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [203.0, 198.0, 195.0, 200.0, 197.0, 197.0, 201.0, 201.0, 198.0, 198.0], "value": 198.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 70.0, 80.0, 149.0, 83.0, 65.0, 56.0, 67.0, 123.0, 57.0], "value": 81.4, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [76.0, 80.0, 109.0, 78.0, 104.0, 130.0, 159.0, 111.0, 79.0, 117.0], "value": 104.3, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 93.0, 88.0, 87.0, 88.0, 85.0, 89.0, 85.0, 88.0, 86.0], "value": 87.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 93.0, 95.0, 93.0, 94.0, 93.0, 94.0, 95.0, 93.0, 95.0], "value": 93.9, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 93.0, 90.0, 92.0, 90.0, 102.0, 127.0, 94.0, 90.0, 91.0], "value": 95.9, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 63.0, 64.0, 64.0, 65.0, 65.0, 78.0, 62.0, 59.0], "value": 64.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 68.0, 87.0, 56.0, 61.0, 90.0, 110.0, 100.0, 60.0, 80.0], "value": 77.5, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 81.0, 78.0, 81.0, 82.0, 80.0, 81.0, 80.0, 84.0, 83.0], "value": 81.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 145.0, 149.0, 129.0, 123.0, 123.0, 124.0, 162.0, 134.0, 141.0], "value": 137.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [167.0, 163.0, 162.0, 167.0, 167.0, 164.0, 162.0, 163.0, 166.0, 164.0], "value": 164.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 67.0, 98.0, 95.0, 99.0, 75.0, 95.0, 73.0, 67.0, 66.0], "value": 80.1, "unit": "score"}], "name": "kraken", "value": 1536.9999999999998, "alertThreshold": 2.0}]} 04:21:28 INFO - Return code: 0 04:21:28 INFO - Validating PERFHERDER_DATA against /builds/slave/test/build/tests/talos/treeherder-schemas/performance-artifact.json 04:21:28 ERROR - # TBPL SUCCESS # 04:21:28 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:21:28 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:21:28 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:21:28 INFO - 2016-07-27 04:21:28.628 screenresolution[2380:18462] starting screenresolution argv=screenresolution get 04:21:28 INFO - 2016-07-27 04:21:28.630 screenresolution[2380:18462] Display 0: 1600x1200x32@60 04:21:28 INFO - 2016-07-27 04:21:28.636 screenresolution[2381:18464] starting screenresolution argv=screenresolution list 04:21:28 INFO - Available Modes on Display 0 04:21:28 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:21:28 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:21:28 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:21:28 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:21:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:21:28 INFO - Intel Iris: 04:21:28 INFO - Chipset Model: Intel Iris 04:21:28 INFO - Type: GPU 04:21:28 INFO - Bus: Built-In 04:21:28 INFO - VRAM (Dynamic, Max): 1536 MB 04:21:28 INFO - Vendor: Intel (0x8086) 04:21:28 INFO - Device ID: 0x0a2e 04:21:28 INFO - Revision ID: 0x0009 04:21:28 INFO - Displays: 04:21:28 INFO - Display: 04:21:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:21:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:21:28 INFO - Display Serial Number: 1600x1200 60 04:21:28 INFO - Main Display: Yes 04:21:28 INFO - Mirror: Off 04:21:28 INFO - Online: Yes 04:21:28 INFO - Rotation: Supported 04:21:28 INFO - Return code: 0 04:21:28 INFO - Running post-action listener: _resource_record_post_action 04:21:28 INFO - Running post-run listener: _resource_record_post_run 04:21:29 INFO - Total resource usage - Wall time: 1193s; CPU: 53.0%; Read bytes: 221696; Write bytes: 495474688; Read time: 6; Write time: 1596 04:21:29 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 191025664; Write bytes: 185793536; Read time: 17266; Write time: 419 04:21:29 INFO - run-tests - Wall time: 1171s; CPU: 53.0%; Read bytes: 188928; Write bytes: 298892288; Read time: 4; Write time: 1137 04:21:29 INFO - Running post-run listener: _upload_blobber_files 04:21:29 INFO - Blob upload gear active. 04:21:29 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:21:29 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:21:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:21:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:21:30 INFO - (blobuploader) - INFO - Open directory for files ... 04:21:30 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_errorsummary.log ... 04:21:30 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:30 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:31 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_errorsummary.log: uploaded 04:21:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:31 INFO - (blobuploader) - INFO - Done attempting. 04:21:31 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs-e10s_raw.log ... 04:21:31 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:21:31 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:21:32 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs-e10s_raw.log: uploaded 04:21:32 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:21:32 INFO - (blobuploader) - INFO - Done attempting. 04:21:32 INFO - (blobuploader) - INFO - Iteration through files over. 04:21:32 INFO - Return code: 0 04:21:32 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:21:32 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:21:32 INFO - Setting buildbot property blobber_files to {"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/358686858c7925dd4fd30546f4f025cd99dfdb731d2f31f4d1b8ffdbe7ccb16b55b5fdc38e0e564ca7dd5f9b7bf9d7b32dc045a966d205920944622f857287d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf72bfe0f65f8e8b2f7004e12bc4e0f557fe672117e978ea3ffd767235e8d3f9aa648ceac28778dd8390438261c9f43e64772e6590da668ea11330436b66ae15"} 04:21:32 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:21:32 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:21:32 INFO - Contents: 04:21:32 INFO - blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/358686858c7925dd4fd30546f4f025cd99dfdb731d2f31f4d1b8ffdbe7ccb16b55b5fdc38e0e564ca7dd5f9b7bf9d7b32dc045a966d205920944622f857287d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf72bfe0f65f8e8b2f7004e12bc4e0f557fe672117e978ea3ffd767235e8d3f9aa648ceac28778dd8390438261c9f43e64772e6590da668ea11330436b66ae15"} 04:21:32 INFO - Running post-run listener: copy_logs_to_upload_dir 04:21:32 INFO - Copying logs to upload dir... 04:21:32 INFO - mkdir: /builds/slave/test/build/upload/logs 04:21:32 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1247.629186 ========= master_lag: 7.47 ========= ========= Finished '/tools/buildbot/bin/python scripts/scripts/talos_script.py ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2016-07-27 04:21:39.811136) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-07-27 04:21:39.814377) ========= 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.XbId30KpPS/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.8weUf5GyPt/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/358686858c7925dd4fd30546f4f025cd99dfdb731d2f31f4d1b8ffdbe7ccb16b55b5fdc38e0e564ca7dd5f9b7bf9d7b32dc045a966d205920944622f857287d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf72bfe0f65f8e8b2f7004e12bc4e0f557fe672117e978ea3ffd767235e8d3f9aa648ceac28778dd8390438261c9f43e64772e6590da668ea11330436b66ae15"} build_url:https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010989 build_url: 'https://queue.taskcluster.net/v1/task/fe-Jm6YcR9i1b06docNOcg/artifacts/public/build/firefox-48.0.en-US.mac.dmg' blobber_files: '{"dromaeojs-e10s_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/358686858c7925dd4fd30546f4f025cd99dfdb731d2f31f4d1b8ffdbe7ccb16b55b5fdc38e0e564ca7dd5f9b7bf9d7b32dc045a966d205920944622f857287d2", "dromaeojs-e10s_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/cf72bfe0f65f8e8b2f7004e12bc4e0f557fe672117e978ea3ffd767235e8d3f9aa648ceac28778dd8390438261c9f43e64772e6590da668ea11330436b66ae15"}' ========= master_lag: 1.13 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 1 secs) (at 2016-07-27 04:21:40.959327) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:40.959683) ========= 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.XbId30KpPS/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.8weUf5GyPt/Listeners TMPDIR=/var/folders/8l/37jgynkn5xx3w6kvn53v07ym00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False program finished with exit code 0 elapsedTime=0.005092 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2016-07-27 04:21:41.000834) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:21:41.001204) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2016-07-27 04:21:41.002728) ========= ========= Total master_lag: 8.72 =========