builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0215 starttime: 1488717340.16 results: success (0) buildid: 20170305030210 builduid: 622dbb97ed5e4bee855d608442a35bfe revision: eb23648534779c110f3a1f2baae1849ae4a9c570 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:40.158007) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:40.158387) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:40.158654) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:40.185874) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:40.186223) ========= 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.ge2FzDsmwh/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.ut0Fg3BR5C/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 --2017-03-05 04:35:40-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 18.8M=0.001s 2017-03-05 04:35:40 (18.8 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.632197 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:40.842493) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:40.842799) ========= 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.ge2FzDsmwh/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.ut0Fg3BR5C/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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.030279 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:40.899800) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:40.900177) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev eb23648534779c110f3a1f2baae1849ae4a9c570 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev eb23648534779c110f3a1f2baae1849ae4a9c570 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ge2FzDsmwh/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.ut0Fg3BR5C/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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 2017-03-05 04:35:41,008 truncating revision to first 12 chars 2017-03-05 04:35:41,008 Setting DEBUG logging. 2017-03-05 04:35:41,008 attempt 1/10 2017-03-05 04:35:41,008 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/eb2364853477?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-05 04:35:41,656 unpacking tar archive at: mozilla-central-eb2364853477/testing/mozharness/ program finished with exit code 0 elapsedTime=0.926082 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:41.850157) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:41.850460) ========= script_repo_revision: eb23648534779c110f3a1f2baae1849ae4a9c570 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:41.850865) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:41.851145) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-05 04:35:41.871379) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-05 04:35:41.871680) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.ge2FzDsmwh/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.ut0Fg3BR5C/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:35:42 INFO - MultiFileLogger online at 20170305 04:35:42 in /builds/slave/test 04:35:42 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:35:42 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:35:42 INFO - {'append_to_log': False, 04:35:42 INFO - 'base_work_dir': '/builds/slave/test', 04:35:42 INFO - 'blob_upload_branch': 'Firefox', 04:35:42 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:35:42 INFO - 'branch': 'Firefox', 04:35:42 INFO - 'buildbot_json_path': 'buildprops.json', 04:35:42 INFO - 'config_files': ('talos/mac_config.py',), 04:35:42 INFO - 'default_actions': ('clobber', 04:35:42 INFO - 'read-buildbot-config', 04:35:42 INFO - 'download-and-extract', 04:35:42 INFO - 'populate-webroot', 04:35:42 INFO - 'create-virtualenv', 04:35:42 INFO - 'install', 04:35:42 INFO - 'run-tests'), 04:35:42 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:35:42 INFO - 'download_minidump_stackwalk': True, 04:35:42 INFO - 'download_symbols': 'ondemand', 04:35:42 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:35:42 INFO - 'tooltool.py': '/tools/tooltool.py', 04:35:42 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:35:42 INFO - '/tools/misc-python/virtualenv.py')}, 04:35:42 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:35:42 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:35:42 INFO - 'gecko_profile': False, 04:35:42 INFO - 'gecko_profile_interval': 0, 04:35:42 INFO - 'installer_path': 'installer.exe', 04:35:42 INFO - 'log_level': 'info', 04:35:42 INFO - 'log_name': 'talos', 04:35:42 INFO - 'log_to_console': True, 04:35:42 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:35:42 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:35:42 INFO - 'opt_config_files': (), 04:35:42 INFO - 'pip_index': False, 04:35:42 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:35:42 INFO - 'cmd': ('bash', 04:35:42 INFO - '-c', 04:35:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:35:42 INFO - 'enabled': True, 04:35:42 INFO - 'halt_on_failure': False, 04:35:42 INFO - 'name': 'check_screen_resolution'},), 04:35:42 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:35:42 INFO - 'cmd': ('bash', 04:35:42 INFO - '-c', 04:35:42 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:35:42 INFO - 'enabled': True, 04:35:42 INFO - 'halt_on_failure': False, 04:35:42 INFO - 'name': 'check_screen_resolution'},), 04:35:42 INFO - 'run_cmd_checks_enabled': True, 04:35:42 INFO - 'suite': 'dromaeojs', 04:35:42 INFO - 'system_bits': '32', 04:35:42 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:35:42 INFO - 'title': 't-yosemite-r7-0215', 04:35:42 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:35:42 INFO - 'use_talos_json': True, 04:35:42 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:35:42 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:35:42 INFO - 'work_dir': 'build'} 04:35:42 INFO - [mozharness: 2017-03-05 12:35:42.087328Z] Running clobber step. 04:35:42 INFO - Running pre-action listener: _resource_record_pre_action 04:35:42 INFO - Running main action method: clobber 04:35:42 INFO - rmtree: /builds/slave/test/build 04:35:42 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:35:44 INFO - Running post-action listener: _resource_record_post_action 04:35:44 INFO - [mozharness: 2017-03-05 12:35:44.622168Z] Finished clobber step (success) 04:35:44 INFO - [mozharness: 2017-03-05 12:35:44.622338Z] Running read-buildbot-config step. 04:35:44 INFO - Running pre-action listener: _resource_record_pre_action 04:35:44 INFO - Running main action method: read_buildbot_config 04:35:44 INFO - Using buildbot properties: 04:35:44 INFO - { 04:35:44 INFO - "project": "", 04:35:44 INFO - "product": "firefox", 04:35:44 INFO - "script_repo_revision": "production", 04:35:44 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:35:44 INFO - "repository": "", 04:35:44 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:35:44 INFO - "buildid": "20170305030210", 04:35:44 INFO - "stage_platform": "macosx64", 04:35:44 INFO - "basedir": "/builds/slave/test", 04:35:44 INFO - "nightly_build": "True", 04:35:44 INFO - "buildnumber": 31, 04:35:44 INFO - "slavename": "t-yosemite-r7-0215", 04:35:44 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:35:44 INFO - "platform": "yosemite_r7", 04:35:44 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:35:44 INFO - "branch": "mozilla-central", 04:35:44 INFO - "repo_path": "mozilla-central", 04:35:44 INFO - "revision": "eb23648534779c110f3a1f2baae1849ae4a9c570", 04:35:44 INFO - "pgo_build": "False", 04:35:44 INFO - "builduid": "622dbb97ed5e4bee855d608442a35bfe", 04:35:44 INFO - "slavebuilddir": "test" 04:35:44 INFO - } 04:35:44 INFO - Found installer url https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:35:44 INFO - Running post-action listener: _resource_record_post_action 04:35:44 INFO - [mozharness: 2017-03-05 12:35:44.625767Z] Finished read-buildbot-config step (success) 04:35:44 INFO - [mozharness: 2017-03-05 12:35:44.625882Z] Running download-and-extract step. 04:35:44 INFO - Running pre-action listener: _resource_record_pre_action 04:35:44 INFO - Running main action method: download_and_extract 04:35:44 INFO - mkdir: /builds/slave/test/build/tests 04:35:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:35:44 INFO - trying https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:35:44 INFO - Downloading https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:35:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:35:46 INFO - Downloaded 1199 bytes. 04:35:46 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:35:46 INFO - Using the following test package requirements: 04:35:46 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:35:46 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:46 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:35:46 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:46 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:35:46 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:46 INFO - u'jsshell-mac.zip'], 04:35:46 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:46 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:35:46 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:35:46 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:46 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:35:46 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:46 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:35:46 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:46 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:35:46 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:35:46 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:35:46 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:35:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:35:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:35:46 INFO - Fetch https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:35:47 INFO - Expected file size: 51775450 04:35:47 INFO - Obtained file size: 51775450 04:36:03 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:36:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:36:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:36:03 INFO - Fetch https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:36:05 INFO - Expected file size: 51775450 04:36:05 INFO - Obtained file size: 51775450 04:36:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:36:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:36:20 INFO - Fetch https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:36:21 INFO - Expected file size: 14404424 04:36:21 INFO - Obtained file size: 14404424 04:36:22 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:22 INFO - trying https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:36:22 INFO - Downloading https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:36:22 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:36:24 INFO - Downloaded 75197249 bytes. 04:36:24 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:36:24 INFO - mkdir: /builds/slave/test/properties 04:36:24 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:36:24 INFO - Writing to file /builds/slave/test/properties/build_url 04:36:24 INFO - Contents: 04:36:24 INFO - build_url:https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:36:24 INFO - Running post-action listener: _resource_record_post_action 04:36:24 INFO - Running post-action listener: set_extra_try_arguments 04:36:24 INFO - [mozharness: 2017-03-05 12:36:24.902621Z] Finished download-and-extract step (success) 04:36:24 INFO - [mozharness: 2017-03-05 12:36:24.902823Z] Running populate-webroot step. 04:36:24 INFO - Running pre-action listener: _resource_record_pre_action 04:36:24 INFO - Running main action method: populate_webroot 04:36:24 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:36:24 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:36:24 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:36:24 INFO - '--tppagecycles', 04:36:24 INFO - '7'], 04:36:24 INFO - 'tests': ['tsvgm']}}, 04:36:24 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:36:24 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:36:24 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:36:24 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:36:24 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:36:24 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:36:24 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:36:24 INFO - 'talos_options': ['--disable-e10s'], 04:36:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:24 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:36:24 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:36:24 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:36:24 INFO - 'talos_options': ['--disable-e10s'], 04:36:24 INFO - 'tests': ['damp', 'tps']}, 04:36:24 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:36:24 INFO - 'tests': ['damp', 'tps']}, 04:36:24 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:36:24 INFO - 'tests': ['dromaeo_dom']}, 04:36:24 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:36:24 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:36:24 INFO - 'tests': ['basic_compositor_video']}, 04:36:24 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:36:24 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:36:24 INFO - 'tests': ['a11yr', 04:36:24 INFO - 'ts_paint', 04:36:24 INFO - 'tpaint', 04:36:24 INFO - 'sessionrestore', 04:36:24 INFO - 'sessionrestore_no_auto_restore', 04:36:24 INFO - 'tabpaint']}, 04:36:24 INFO - 'other-e10s': {'tests': ['a11yr', 04:36:24 INFO - 'ts_paint', 04:36:24 INFO - 'tpaint', 04:36:24 INFO - 'sessionrestore', 04:36:24 INFO - 'sessionrestore_no_auto_restore', 04:36:24 INFO - 'tabpaint']}, 04:36:24 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:36:24 INFO - 'ts_paint', 04:36:24 INFO - 'tpaint', 04:36:24 INFO - 'sessionrestore', 04:36:24 INFO - 'sessionrestore_no_auto_restore', 04:36:24 INFO - 'tabpaint']}, 04:36:24 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:36:24 INFO - 'ts_paint', 04:36:24 INFO - 'tpaint', 04:36:24 INFO - 'sessionrestore', 04:36:24 INFO - 'sessionrestore_no_auto_restore', 04:36:24 INFO - 'tabpaint']}, 04:36:24 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:36:24 INFO - 'tests': ['a11yr', 04:36:24 INFO - 'ts_paint', 04:36:24 INFO - 'tpaint', 04:36:24 INFO - 'sessionrestore', 04:36:24 INFO - 'sessionrestore_no_auto_restore', 04:36:24 INFO - 'tabpaint']}, 04:36:24 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:36:24 INFO - 'tests': ['a11yr', 04:36:24 INFO - 'ts_paint', 04:36:24 INFO - 'tpaint', 04:36:24 INFO - 'sessionrestore', 04:36:24 INFO - 'sessionrestore_no_auto_restore', 04:36:24 INFO - 'tabpaint']}, 04:36:24 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:36:24 INFO - 'tests': ['tsvgx', 04:36:24 INFO - 'tsvgr_opacity', 04:36:24 INFO - 'tart', 04:36:24 INFO - 'tscrollx', 04:36:24 INFO - 'cart', 04:36:24 INFO - 'tsvg_static']}, 04:36:24 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:36:24 INFO - 'tsvgr_opacity', 04:36:24 INFO - 'tart', 04:36:24 INFO - 'tscrollx', 04:36:24 INFO - 'cart', 04:36:24 INFO - 'tsvg_static']}, 04:36:24 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:36:24 INFO - 'talos_options': ['--disable-e10s'], 04:36:24 INFO - 'tests': ['tp5o']}, 04:36:24 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:36:24 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:36:24 INFO - 'talos_options': ['--disable-e10s', 04:36:24 INFO - '--xperf_path', 04:36:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:24 INFO - 'tests': ['tp5n']}, 04:36:24 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:36:24 INFO - 'talos_options': ['--xperf_path', 04:36:24 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:36:24 INFO - 'tests': ['tp5n']}}, 04:36:24 INFO - 'talos.zip': {'path': '', 04:36:24 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:36:24 INFO - Running post-action listener: _resource_record_post_action 04:36:24 INFO - [mozharness: 2017-03-05 12:36:24.923749Z] Finished populate-webroot step (success) 04:36:24 INFO - [mozharness: 2017-03-05 12:36:24.923865Z] Running create-virtualenv step. 04:36:24 INFO - Running pre-action listener: _resource_record_pre_action 04:36:24 INFO - Running main action method: create_virtualenv 04:36:24 INFO - Creating virtualenv /builds/slave/test/build/venv 04:36:24 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:36:24 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:36:25 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:36:25 INFO - Using real prefix '/tools/python27' 04:36:25 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:36:25 INFO - Installing distribute.............................................................................................................................................................................................done. 04:36:28 INFO - Installing pip.................done. 04:36:28 INFO - Return code: 0 04:36:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:36:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:36:28 INFO - Reading from file tmpfile_stdout 04:36:28 INFO - Output received: 04:36:28 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:36:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:36:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:28 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:28 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 0x100719b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10071c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc669c66670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004f7d30>, '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 0x10041edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004ecbe8>, '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.ge2FzDsmwh/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.ut0Fg3BR5C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:36:28 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:36:28 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:36:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ge2FzDsmwh/Render', 04:36:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:28 INFO - 'HOME': '/Users/cltbld', 04:36:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:28 INFO - 'LOGNAME': 'cltbld', 04:36:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:28 INFO - 'MOZ_NO_REMOTE': '1', 04:36:28 INFO - 'NO_EM_RESTART': '1', 04:36:28 INFO - 'PAGER': '/bin/cat', 04:36:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:28 INFO - 'PWD': '/builds/slave/test', 04:36:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:28 INFO - 'SHELL': '/bin/bash', 04:36:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut0Fg3BR5C/Listeners', 04:36:28 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 04:36:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:28 INFO - 'USER': 'cltbld', 04:36:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:28 INFO - 'XPC_FLAGS': '0x0', 04:36:28 INFO - 'XPC_SERVICE_NAME': '0', 04:36:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:29 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:36:29 INFO - Cleaning up... 04:36:29 INFO - Return code: 0 04:36:29 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:29 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>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100719b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10071c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc669c66670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004f7d30>, '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 0x10041edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004ecbe8>, '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.ge2FzDsmwh/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.ut0Fg3BR5C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:36:29 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>=3.1.1'] in /builds/slave/test/build 04:36:29 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>=3.1.1 04:36:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ge2FzDsmwh/Render', 04:36:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:29 INFO - 'HOME': '/Users/cltbld', 04:36:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:29 INFO - 'LOGNAME': 'cltbld', 04:36:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:29 INFO - 'MOZ_NO_REMOTE': '1', 04:36:29 INFO - 'NO_EM_RESTART': '1', 04:36:29 INFO - 'PAGER': '/bin/cat', 04:36:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:29 INFO - 'PWD': '/builds/slave/test', 04:36:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:29 INFO - 'SHELL': '/bin/bash', 04:36:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut0Fg3BR5C/Listeners', 04:36:29 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 04:36:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:29 INFO - 'USER': 'cltbld', 04:36:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:29 INFO - 'XPC_FLAGS': '0x0', 04:36:29 INFO - 'XPC_SERVICE_NAME': '0', 04:36:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:29 INFO - Downloading/unpacking psutil>=3.1.1 04:36: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:36: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:36: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:36: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:36: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:36: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:36:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:36:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:33 INFO - Installing collected packages: psutil 04:36:33 INFO - Running setup.py install for psutil 04:36:33 INFO - building 'psutil._psutil_osx' extension 04:36:33 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:36:34 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:36:34 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:36:34 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:36:34 INFO - building 'psutil._psutil_posix' extension 04:36:34 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:36:34 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:36:34 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:36:34 INFO - ^ 04:36:34 INFO - 1 warning generated. 04:36:34 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:36:34 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:36:34 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:36:34 INFO - Successfully installed psutil 04:36:34 INFO - Cleaning up... 04:36:34 INFO - Return code: 0 04:36:34 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:34 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.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100719b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10071c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc669c66670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004f7d30>, '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 0x10041edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004ecbe8>, '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.ge2FzDsmwh/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.ut0Fg3BR5C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:36:34 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.3'] in /builds/slave/test/build 04:36:34 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.3 04:36:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ge2FzDsmwh/Render', 04:36:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:34 INFO - 'HOME': '/Users/cltbld', 04:36:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:34 INFO - 'LOGNAME': 'cltbld', 04:36:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:34 INFO - 'MOZ_NO_REMOTE': '1', 04:36:34 INFO - 'NO_EM_RESTART': '1', 04:36:34 INFO - 'PAGER': '/bin/cat', 04:36:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:34 INFO - 'PWD': '/builds/slave/test', 04:36:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:34 INFO - 'SHELL': '/bin/bash', 04:36:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut0Fg3BR5C/Listeners', 04:36:34 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 04:36:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:34 INFO - 'USER': 'cltbld', 04:36:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:34 INFO - 'XPC_FLAGS': '0x0', 04:36:34 INFO - 'XPC_SERVICE_NAME': '0', 04:36:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:36: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:36: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:36: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:36: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:36: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:36: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:36:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:36:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:36:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:36:37 INFO - Installing collected packages: mozsystemmonitor 04:36:37 INFO - Running setup.py install for mozsystemmonitor 04:36:37 INFO - Successfully installed mozsystemmonitor 04:36:37 INFO - Cleaning up... 04:36:37 INFO - Return code: 0 04:36:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:36:37 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:37 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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:37 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==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100719b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10071c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc669c66670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004f7d30>, '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 0x10041edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004ecbe8>, '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.ge2FzDsmwh/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.ut0Fg3BR5C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:36:37 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==2.5.1'] in /builds/slave/test/build 04:36:37 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==2.5.1 04:36:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ge2FzDsmwh/Render', 04:36:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:37 INFO - 'HOME': '/Users/cltbld', 04:36:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:37 INFO - 'LOGNAME': 'cltbld', 04:36:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:37 INFO - 'MOZ_NO_REMOTE': '1', 04:36:37 INFO - 'NO_EM_RESTART': '1', 04:36:37 INFO - 'PAGER': '/bin/cat', 04:36:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:37 INFO - 'PWD': '/builds/slave/test', 04:36:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:37 INFO - 'SHELL': '/bin/bash', 04:36:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut0Fg3BR5C/Listeners', 04:36:37 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 04:36:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:37 INFO - 'USER': 'cltbld', 04:36:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:37 INFO - 'XPC_FLAGS': '0x0', 04:36:37 INFO - 'XPC_SERVICE_NAME': '0', 04:36:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:38 INFO - Downloading/unpacking jsonschema==2.5.1 04:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:36:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:36:40 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:36:40 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:36:40 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:36:40 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:36:40 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:36:40 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:36:41 INFO - Downloading functools32-3.2.3-2.tar.gz 04:36:41 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:36:41 INFO - warning: no files found matching '*.txt' 04:36:41 INFO - no previously-included directories found matching 'build' 04:36:41 INFO - no previously-included directories found matching 'dist' 04:36:41 INFO - no previously-included directories found matching '.git*' 04:36:41 INFO - Installing collected packages: jsonschema, functools32 04:36:41 INFO - Running setup.py install for functools32 04:36:41 INFO - warning: no files found matching '*.txt' 04:36:41 INFO - no previously-included directories found matching 'build' 04:36:41 INFO - no previously-included directories found matching 'dist' 04:36:41 INFO - no previously-included directories found matching '.git*' 04:36:41 INFO - Successfully installed jsonschema functools32 04:36:41 INFO - Cleaning up... 04:36:41 INFO - Return code: 0 04:36:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:41 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', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x100719b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10071c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc669c66670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004f7d30>, '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 0x10041edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004ecbe8>, '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.ge2FzDsmwh/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.ut0Fg3BR5C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:36:41 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', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:36:41 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 functools32==3.2.3-2 04:36:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ge2FzDsmwh/Render', 04:36:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:41 INFO - 'HOME': '/Users/cltbld', 04:36:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:41 INFO - 'LOGNAME': 'cltbld', 04:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:41 INFO - 'MOZ_NO_REMOTE': '1', 04:36:41 INFO - 'NO_EM_RESTART': '1', 04:36:41 INFO - 'PAGER': '/bin/cat', 04:36:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:41 INFO - 'PWD': '/builds/slave/test', 04:36:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:41 INFO - 'SHELL': '/bin/bash', 04:36:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut0Fg3BR5C/Listeners', 04:36:41 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 04:36:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:41 INFO - 'USER': 'cltbld', 04:36:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:41 INFO - 'XPC_FLAGS': '0x0', 04:36:41 INFO - 'XPC_SERVICE_NAME': '0', 04:36:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:36:41 INFO - Cleaning up... 04:36:41 INFO - Return code: 0 04:36:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:41 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 0x100719b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10071c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc669c66670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004f7d30>, '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 0x10041edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004ecbe8>, '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.ge2FzDsmwh/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.ut0Fg3BR5C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:36:41 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:36:41 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:36:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ge2FzDsmwh/Render', 04:36:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:41 INFO - 'HOME': '/Users/cltbld', 04:36:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:41 INFO - 'LOGNAME': 'cltbld', 04:36:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:41 INFO - 'MOZ_NO_REMOTE': '1', 04:36:41 INFO - 'NO_EM_RESTART': '1', 04:36:41 INFO - 'PAGER': '/bin/cat', 04:36:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:41 INFO - 'PWD': '/builds/slave/test', 04:36:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:41 INFO - 'SHELL': '/bin/bash', 04:36:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut0Fg3BR5C/Listeners', 04:36:41 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 04:36:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:41 INFO - 'USER': 'cltbld', 04:36:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:41 INFO - 'XPC_FLAGS': '0x0', 04:36:41 INFO - 'XPC_SERVICE_NAME': '0', 04:36:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:42 INFO - Downloading/unpacking blobuploader==1.2.4 04:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:44 INFO - Downloading blobuploader-1.2.4.tar.gz 04:36:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:36:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:36:44 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:36:44 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:36:44 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:36:44 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:36:44 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:36:44 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:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:36:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:36:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:36:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:36:45 INFO - Downloading docopt-0.6.1.tar.gz 04:36:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:36:45 INFO - Installing collected packages: blobuploader, requests, docopt 04:36:45 INFO - Running setup.py install for blobuploader 04:36:46 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:36:46 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:36:46 INFO - Running setup.py install for requests 04:36:46 INFO - Running setup.py install for docopt 04:36:46 INFO - Successfully installed blobuploader requests docopt 04:36:46 INFO - Cleaning up... 04:36:46 INFO - Return code: 0 04:36:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:46 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 0x100719b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10071c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc669c66670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004f7d30>, '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 0x10041edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004ecbe8>, '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.ge2FzDsmwh/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.ut0Fg3BR5C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:36:46 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:36:46 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:36:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ge2FzDsmwh/Render', 04:36:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:46 INFO - 'HOME': '/Users/cltbld', 04:36:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:46 INFO - 'LOGNAME': 'cltbld', 04:36:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:46 INFO - 'MOZ_NO_REMOTE': '1', 04:36:46 INFO - 'NO_EM_RESTART': '1', 04:36:46 INFO - 'PAGER': '/bin/cat', 04:36:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:46 INFO - 'PWD': '/builds/slave/test', 04:36:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:46 INFO - 'SHELL': '/bin/bash', 04:36:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut0Fg3BR5C/Listeners', 04:36:46 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 04:36:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:46 INFO - 'USER': 'cltbld', 04:36:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:46 INFO - 'XPC_FLAGS': '0x0', 04:36:46 INFO - 'XPC_SERVICE_NAME': '0', 04:36:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:47 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-nEKfRo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:47 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-11kWM4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:47 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-jHtuYX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:47 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-yU1qUd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:47 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-FlnO5y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:47 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-O6D6oW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:47 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-c1gZN1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:47 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-Ihv5Li-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:47 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-blgJzL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:48 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-4ypcW1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:48 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-wQS96z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:48 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-YJA9Kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:48 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-3BaNXw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:48 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-YLA8kA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:48 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-6qGnsQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:48 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-Gr9Dbx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:48 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-LVr0ot-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:36:48 INFO - Running setup.py install for manifestparser 04:36:49 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:36:49 INFO - Running setup.py install for mozcrash 04:36:49 INFO - Running setup.py install for mozdebug 04:36:49 INFO - Running setup.py install for mozdevice 04:36:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:36:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:36:49 INFO - Running setup.py install for mozfile 04:36:49 INFO - Running setup.py install for mozhttpd 04:36:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:36:49 INFO - Running setup.py install for mozinfo 04:36:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:36:49 INFO - Running setup.py install for mozInstall 04:36:50 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:36:50 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:36:50 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:36:50 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:36:50 INFO - Running setup.py install for mozleak 04:36:50 INFO - Running setup.py install for mozlog 04:36:50 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:36:50 INFO - Running setup.py install for moznetwork 04:36:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:36:50 INFO - Running setup.py install for mozprocess 04:36:50 INFO - Running setup.py install for mozprofile 04:36:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:36:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:36:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:36:50 INFO - Running setup.py install for mozrunner 04:36:51 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Running setup.py install for mozscreenshot 04:36:51 INFO - Running setup.py install for moztest 04:36:51 INFO - Running setup.py install for mozversion 04:36:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:36:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:36:51 INFO - Cleaning up... 04:36:51 INFO - Return code: 0 04:36:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:51 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 0x100719b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10071c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc669c66670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004f7d30>, '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 0x10041edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004ecbe8>, '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.ge2FzDsmwh/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.ut0Fg3BR5C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:36:51 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:36:51 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:36:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ge2FzDsmwh/Render', 04:36:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:51 INFO - 'HOME': '/Users/cltbld', 04:36:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:51 INFO - 'LOGNAME': 'cltbld', 04:36:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:51 INFO - 'MOZ_NO_REMOTE': '1', 04:36:51 INFO - 'NO_EM_RESTART': '1', 04:36:51 INFO - 'PAGER': '/bin/cat', 04:36:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:51 INFO - 'PWD': '/builds/slave/test', 04:36:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:51 INFO - 'SHELL': '/bin/bash', 04:36:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut0Fg3BR5C/Listeners', 04:36:51 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 04:36:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:51 INFO - 'USER': 'cltbld', 04:36:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:51 INFO - 'XPC_FLAGS': '0x0', 04:36:51 INFO - 'XPC_SERVICE_NAME': '0', 04:36:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:36:51 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-u5Cqso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:36:51 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:36:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:36:51 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-tS4vMt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 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:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:36:52 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-gLhLX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:36:52 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:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:36:52 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-DsPJh0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 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:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:36:52 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-juy3ZY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:36:52 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:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:36:52 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-AQKnHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:36:52 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:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:36:52 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-OJIpa4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:36:52 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:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:36:52 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-UYYt_f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:36:52 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:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:36:52 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-UMxKKj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:36:52 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:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:36:52 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-hZb1jg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:36:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 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:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:36:52 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-FPcg0t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:36:52 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:36:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:36:52 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-WTXUAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:36:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 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:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:36:53 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-CIPm7B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:36:53 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:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:36:53 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-BkgU29-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:36:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 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:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:53 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-Wgs9iG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:36:53 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:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:36:53 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-0S4Msr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:36:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 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:36:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:36:53 INFO - Running setup.py (path:/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/pip-FqPGA6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:36:53 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:36:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:36:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:36:53 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:36:53 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:36:53 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.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:36:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:36:53 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:36:53 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:36:53 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:36:53 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:36:53 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:36:53 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:36:56 INFO - Downloading blessings-1.6.tar.gz 04:36:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:36:56 INFO - Installing collected packages: blessings 04:36:56 INFO - Running setup.py install for blessings 04:36:56 INFO - Successfully installed blessings 04:36:56 INFO - Cleaning up... 04:36:56 INFO - Return code: 0 04:36:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:36:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:56 INFO - Reading from file tmpfile_stdout 04:36:56 INFO - Current package versions: 04:36:56 INFO - blessings == 1.6 04:36:56 INFO - blobuploader == 1.2.4 04:36:56 INFO - docopt == 0.6.1 04:36:56 INFO - functools32 == 3.2.3-2 04:36:56 INFO - jsonschema == 2.5.1 04:36:56 INFO - manifestparser == 1.1 04:36:56 INFO - mozInstall == 1.12 04:36:56 INFO - mozcrash == 1.0 04:36:56 INFO - mozdebug == 0.1 04:36:56 INFO - mozdevice == 0.49 04:36:56 INFO - mozfile == 1.2 04:36:56 INFO - mozhttpd == 0.7 04:36:56 INFO - mozinfo == 0.9 04:36:56 INFO - mozleak == 0.1 04:36:56 INFO - mozlog == 3.4 04:36:56 INFO - moznetwork == 0.27 04:36:56 INFO - mozprocess == 0.25 04:36:56 INFO - mozprofile == 0.28 04:36:56 INFO - mozrunner == 6.13 04:36:56 INFO - mozscreenshot == 0.1 04:36:56 INFO - mozsystemmonitor == 0.3 04:36:56 INFO - moztest == 0.8 04:36:56 INFO - mozversion == 1.4 04:36:56 INFO - psutil == 3.1.1 04:36:56 INFO - requests == 1.2.3 04:36:56 INFO - wsgiref == 0.1.2 04:36:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:56 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 0x100719b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10071c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc669c66670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004f7d30>, '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 0x10041edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004ecbe8>, '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.ge2FzDsmwh/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.ut0Fg3BR5C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:36:56 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:36:56 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:36:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ge2FzDsmwh/Render', 04:36:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:56 INFO - 'HOME': '/Users/cltbld', 04:36:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:56 INFO - 'LOGNAME': 'cltbld', 04:36:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:56 INFO - 'MOZ_NO_REMOTE': '1', 04:36:56 INFO - 'NO_EM_RESTART': '1', 04:36:56 INFO - 'PAGER': '/bin/cat', 04:36:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:56 INFO - 'PWD': '/builds/slave/test', 04:36:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:56 INFO - 'SHELL': '/bin/bash', 04:36:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut0Fg3BR5C/Listeners', 04:36:56 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 04:36:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:56 INFO - 'USER': 'cltbld', 04:36:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:56 INFO - 'XPC_FLAGS': '0x0', 04:36:56 INFO - 'XPC_SERVICE_NAME': '0', 04:36:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:57 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:36:57 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:36:57 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:36:57 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:36:57 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:36:57 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:36:57 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:36:57 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:36:57 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:36:57 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:36:57 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:36:57 INFO - Cleaning up... 04:36:57 INFO - Return code: 0 04:36:57 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:36:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36: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://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:36:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:36:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:36:57 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 0x100719b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10071c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fc669c66670>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004f7d30>, '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 0x10041edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004ecbe8>, '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.ge2FzDsmwh/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.ut0Fg3BR5C/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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:36:57 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:36:57 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:36:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ge2FzDsmwh/Render', 04:36:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:36:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:36:57 INFO - 'HOME': '/Users/cltbld', 04:36:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:36:57 INFO - 'LOGNAME': 'cltbld', 04:36:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:36:57 INFO - 'MOZ_NO_REMOTE': '1', 04:36:57 INFO - 'NO_EM_RESTART': '1', 04:36:57 INFO - 'PAGER': '/bin/cat', 04:36:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:36:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:36:57 INFO - 'PWD': '/builds/slave/test', 04:36:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:36:57 INFO - 'SHELL': '/bin/bash', 04:36:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut0Fg3BR5C/Listeners', 04:36:57 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 04:36:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:36:57 INFO - 'USER': 'cltbld', 04:36:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:36:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:36:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:36:57 INFO - 'XPC_FLAGS': '0x0', 04:36:57 INFO - 'XPC_SERVICE_NAME': '0', 04:36:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:36:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:36:57 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:36:57 INFO - Cleaning up... 04:36:57 INFO - Return code: 0 04:36:57 INFO - Running post-action listener: _resource_record_post_action 04:36:57 INFO - Running post-action listener: _start_resource_monitoring 04:36:57 INFO - Starting resource monitoring. 04:36:57 INFO - [mozharness: 2017-03-05 12:36:57.530693Z] Finished create-virtualenv step (success) 04:36:57 INFO - [mozharness: 2017-03-05 12:36:57.531664Z] Running install step. 04:36:57 INFO - Running pre-action listener: _resource_record_pre_action 04:36:57 INFO - Running main action method: install 04:36:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:36:57 INFO - Reading from file tmpfile_stdout 04:36:57 INFO - Detecting whether we're running mozinstall >=1.0... 04:36:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:36:57 INFO - Reading from file tmpfile_stdout 04:36:57 INFO - Output received: 04:36:57 INFO - Usage: mozinstall [options] installer 04:36:57 INFO - Options: 04:36:57 INFO - -h, --help show this help message and exit 04:36:57 INFO - -d DEST, --destination=DEST 04:36:57 INFO - Directory to install application into. [default: 04:36:57 INFO - "/builds/slave/test"] 04:36:57 INFO - --app=APP Application being installed. [default: firefox] 04:36:57 INFO - mkdir: /builds/slave/test/build/application 04:36:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:36:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:37:18 INFO - Reading from file tmpfile_stdout 04:37:18 INFO - Output received: 04:37:18 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:37:18 INFO - Running post-action listener: _resource_record_post_action 04:37:18 INFO - [mozharness: 2017-03-05 12:37:18.268040Z] Finished install step (success) 04:37:18 INFO - [mozharness: 2017-03-05 12:37:18.268175Z] Running run-tests step. 04:37:18 INFO - Running pre-action listener: _resource_record_pre_action 04:37:18 INFO - Running main action method: run_tests 04:37:18 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:37:18 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:37:18 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:37:18 INFO - 2017-03-05 04:37:18.282 screenresolution[1640:9413] starting screenresolution argv=screenresolution get 04:37:18 INFO - 2017-03-05 04:37:18.285 screenresolution[1640:9413] Display 0: 1600x1200x32@60 04:37:18 INFO - 2017-03-05 04:37:18.291 screenresolution[1641:9416] starting screenresolution argv=screenresolution list 04:37:18 INFO - Available Modes on Display 0 04:37:18 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:37:18 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:37:18 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:37:18 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:37:18 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:37:18 INFO - Intel Iris: 04:37:18 INFO - Chipset Model: Intel Iris 04:37:18 INFO - Type: GPU 04:37:18 INFO - Bus: Built-In 04:37:18 INFO - VRAM (Dynamic, Max): 1536 MB 04:37:18 INFO - Vendor: Intel (0x8086) 04:37:18 INFO - Device ID: 0x0a2e 04:37:18 INFO - Revision ID: 0x0009 04:37:18 INFO - Displays: 04:37:18 INFO - Display: 04:37:18 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:37:18 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:37:18 INFO - Display Serial Number: 1600x1200 60 04:37:18 INFO - Main Display: Yes 04:37:18 INFO - Mirror: Off 04:37:18 INFO - Online: Yes 04:37:18 INFO - Rotation: Supported 04:37:18 INFO - Return code: 0 04:37:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:37:18 INFO - Python 2.7.3 04:37:18 INFO - Return code: 0 04:37:18 INFO - grabbing minidump binary from tooltool 04:37:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:37:18 INFO - retry: Calling run_command with args: (['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'],), kwargs: {'output_timeout': 600, 'error_list': [{'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1004f7d30>, '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 0x10041edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1004ecbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:37:18 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:37:18 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:37:18 INFO - Calling ['/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'] with output_timeout 600 04:37:18 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:37:18 INFO - Return code: 0 04:37:18 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:37:18 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:37:18 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:37:18 INFO - ENV: RUST_BACKTRACE is now 1 04:37:18 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:37:18 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:37:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0215', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:37:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0215 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:37:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.ge2FzDsmwh/Render', 04:37:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:37:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:37:18 INFO - 'HOME': '/Users/cltbld', 04:37:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:37:18 INFO - 'LOGNAME': 'cltbld', 04:37:18 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:37:18 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:37:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:37:18 INFO - 'MOZ_NO_REMOTE': '1', 04:37:18 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:37:18 INFO - 'NO_EM_RESTART': '1', 04:37:18 INFO - 'PAGER': '/bin/cat', 04:37:18 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:37:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:37:18 INFO - 'PWD': '/builds/slave/test', 04:37:18 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:37:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:37:18 INFO - 'RUST_BACKTRACE': '1', 04:37:18 INFO - 'SHELL': '/bin/bash', 04:37:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.ut0Fg3BR5C/Listeners', 04:37:18 INFO - 'TMPDIR': '/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/', 04:37:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:37:18 INFO - 'USER': 'cltbld', 04:37:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:37:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:37:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:37:18 INFO - 'XPC_FLAGS': '0x0', 04:37:18 INFO - 'XPC_SERVICE_NAME': '0', 04:37:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:37:18 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0215', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:37:18 INFO - mozversion application_buildid: 20170305030210 04:37:18 INFO - mozversion application_changeset: eb23648534779c110f3a1f2baae1849ae4a9c570 04:37:18 INFO - mozversion application_display_name: Nightly 04:37:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:37:18 INFO - mozversion application_name: Firefox 04:37:18 INFO - mozversion application_remotingname: firefox 04:37:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:37:18 INFO - mozversion application_vendor: Mozilla 04:37:18 INFO - mozversion application_version: 54.0a1 04:37:18 INFO - mozversion platform_buildid: 20170305030210 04:37:18 INFO - mozversion platform_changeset: eb23648534779c110f3a1f2baae1849ae4a9c570 04:37:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:37:18 INFO - mozversion platform_version: 54.0a1 04:37:18 INFO - using testdate: 1488717438 04:37:18 INFO - actual date: 1488717438 04:37:18 INFO - starting webserver on 'localhost:49245' 04:37:18 INFO - SUITE-START | Running 2 tests 04:37:18 INFO - TEST-START | dromaeo_css 04:37:18 INFO - operating with platform_type : mac_ 04:37:18 INFO - Initialising browser for dromaeo_css test... 04:37:18 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmpaoKzeC/profile http://localhost:49245/getInfo.html) 04:37:21 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 04:37:21 INFO - PROCESS | 1651 | colorDepth:24 04:37:21 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 04:37:21 INFO - PROCESS | 1651 | __metrics 04:37:21 INFO - PROCESS | 1651 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:37:21 INFO - PROCESS | 1651 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:37:22 INFO - TEST-INFO | 1651: exit 0 04:37:22 INFO - Browser initialized. 04:37:22 INFO - Running cycle 1/1 for dromaeo_css test... 04:37:22 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmpaoKzeC/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:37:34 INFO - PROCESS | 1655 | RSS: Main: 232497152 04:37:34 INFO - PROCESS | 1655 | 04:40:39 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49245/tests/dromaeo/cssquery-ext.html) 04:40:41 INFO - PROCESS | 1655 | RSS: Main: 443457536 04:40:41 INFO - PROCESS | 1655 | 04:42:24 INFO - PROCESS | 1655 | ************************* 04:42:24 INFO - PROCESS | 1655 | A coding exception was thrown and uncaught in a Task. 04:42:24 INFO - PROCESS | 1655 | 04:42:24 ERROR - PROCESS | 1655 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:42:24 INFO - PROCESS | 1655 | Full stack: 04:42:24 INFO - PROCESS | 1655 | ************************* 04:43:44 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-ext.html (next: http://localhost:49245/tests/dromaeo/cssquery-jquery.html) 04:43:45 INFO - PROCESS | 1655 | RSS: Main: 361902080 04:43:45 INFO - PROCESS | 1655 | 04:46:47 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49245/tests/dromaeo/cssquery-mootools.html) 04:46:48 INFO - PROCESS | 1655 | RSS: Main: 351416320 04:46:48 INFO - PROCESS | 1655 | 04:49:51 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49245/tests/dromaeo/cssquery-prototype.html) 04:49:51 INFO - PROCESS | 1655 | RSS: Main: 330690560 04:49:51 INFO - PROCESS | 1655 | 04:52:55 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49245/tests/dromaeo/cssquery-yui.html) 04:52:56 INFO - PROCESS | 1655 | RSS: Main: 336232448 04:52:56 INFO - PROCESS | 1655 | 04:55:59 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49245/tests/dromaeo/cssquery-yui.html (next: http://localhost:49245/tests/dromaeo/cssquery-dojo.html) 04:55:59 INFO - PROCESS | 1655 | RSS: Main: 422490112 04:55:59 INFO - PROCESS | 1655 | 04:55:59 INFO - PROCESS | 1655 | __start_tp_report 04:55:59 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 04:55:59 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 04:55:59 INFO - PROCESS | 1655 | |i|pagename|runs| 04:55:59 INFO - PROCESS | 1655 | |0;dojo.html;3071.8003329783564;3343.866245350186;3346.9665303346965;3360.143163493312;3406.489026646003;5612.354579223391;5655.971720141393;5777.537796976242;5923.73343199556;5930.5848590598625;5665.065264231397;5742.54059675226;5750.856228594287;5763.625364351315;5767.048437007899;5139.4346621871655;5187.429382767892;5187.766550505217;5227.137522308814;5230.633855630107;4364.716293440932;5255.448177941318;5269.789208431658;5275.920861187085;5289.973550132244;5264.1051021326275;5264.447233040533;5269.262303277545;5278.47215278471;5285.947140528603;5130.20481825314;5262.236975638511;5281.841544753664;5284.735763211843;5290.497402746733;4506.369108324837;5103.923441148386;5217.5565076968505;5219.451957544441;5232.293640358541;5988.580799344048;6019.518438524908;6032.065029920369;6032.245969253843;6035.818925432244;6161.19904412428;6179.845503862394;6190.535709821736;6194.5044396448175;6204.720787564525;6140.60946423305;6161.168242287279;6209.16176316196;6248.5313601480075;6251.499880009588;5294.311739473882;5804.738786754606;5819.825405237807;5827.155062515996;5870.882582348329;6200.627962322275;6284.214473190851;6316.336784637547;6316.589421687576;6322.873542529123;6219.129321894939;6238.313785483593;6241.282252540925;6249.187605611241;6278.466330361879;6213.689315534205;6220.720067596969;6231.065340199007;6234.688265586702;6250.531210159165;6027.8794424111275;6130.409625092252;6160.8767824643255;6181.660008699565;6223.408776166257;6180.783672571439;6214.533909956771;6216.7824126155365;6219.0982307566055;6230.688465576703;5018.222175562721;5068.087744206005;5069;5073.010762901273;5082.517160869711;4387.2103021455805;4442.333649952533;4466.888327791831;4470.173017991682;4504.076664283814;5777.422257774189;5793.478586927196;5795.797147099831;5813.563982701315;5834.387389324144;6205.596636218631;6207.286162091327;6218.968905155445;6221.844453888599;6222.097795819581;5522.779088836402;5534.280543529396;5588.1059030555725;5739.540836733051;5748.913766293509;5443.401225865152;5450.427705090988;5451.645643033269;5456.48163424474;5470.972645136829;6189.783357582463;6262.1859158310035;6269.090981807703;6288.622682639057;6345.650989195638;6256.186695729526;6264.21697287839;6270;6273;6276.843078923063;6381.425671689571;6391.744330226739;6392.808215753535;6394.840128996812;6398.264199617103;6103.816885493442;6132.753252973555;6299.874002520016;6318.241810982711;6327.651979141191;6071.969640151771;6247.250329960434;6255.593386429868;6261.78083767066;6267.655278959701;6042.758289668364;6079.148919151411;6097.024476083805;6106.419890110433;6109.20580324555;6118.375534461997;6159.630422174684;6215.316315205414;6233.345498722569;6236.314005459305;6084.700952760976;6094.847628809315;6098.481629061579;6101.60339577926;6127.969360153349;6212.24165341816;6250.406211409909;6265.592736472115;6268;6270.7805226816845;5812.883742325214;5848.53211743051;5905.940940590539;5906.1140828874295;5908.852278693067 04:55:59 INFO - PROCESS | 1655 | |1;ext.html;775.097011981042;797.1231645190292;863.1799790199308;873.4671850171394;874.855648817945;31654;39532.20935581287;39575;39711.80144099283;39764.80117599415;40833;40936.79531602338;40966.38550421739;41196;41252;7467.178610352884;9262.861057084148;9452.432854028746;9459.763505912339;9460.716178514622;7508.361789247921;7610.467267291292;7610.809729756773;7613.771586852404;11050;9552.57013434397;11276.943615281913;11286.322820630747;11294.378809165493;11320.6037788677;11196.66410007701;11224.66326010221;11248;11257.211995160342;11262.436878156059;7345.338919497271;7482.925170748332;10950.945245273802;10986.066184374338;11001.504932277987;28227;28414.147575572766;38170.045748856224;38608;40613;3816.8091595420397;3817.9618203817886;3877.5734669186368;3885.203533275672;3987.2224916141363;28765.856170719013;28771.28071798201;28793.712062879524;29000.564991525145;29790.851045744632;3113.641931177921;3142.355817057498;3168.746500279972;3234.6280177779386;3263.331017141504;315397;317530;318969.9999999977;319958;321629.3918530416;50697;50749.731256718136;50755.73110672189;50819;50996.98006039933;53505.1974220387;53560.19659705029;53585.73207134017;53654;53684.73157634187;13788.517401890886;14107.929460352838;14122.364493597814;14127.434902603985;14129.57611271643;12001.63995080149;12009.279443233434;12019.699507512207;12030.218035827644;12034.157608967289;12368.134230603771;12701.555445559361;12702.872971270353;12772.297523636104;12822.9358853207;5287.524122828964;5347.438518955531;5352.785888564414;5354.491323324278;5371.75827087782;1085.3162507620307;1123.9044681202026;1138.4364739454024;1162.65770223431;1171.4377098992532;25030;26243.606345904827;26378.194105949464;26544.469110618065;26573.468530629278;1206.1617176062728;1208.3837243005955;1217.3852204636778;1248.7252804383204;1255.7300180461245;11747;13460.326983650779;13830.723385532234;13851.930740346435;13912;392882;393873;395445;395734;397228;54996.725016374665;55087;55096;55108.72445637746;55116;1214.884585964332;1374.2853716067789;1425.4369524037947;1426.429428228696;1428.9499867504796;20515.692264615744;21595.676064859355;29801.25496862596;30067.94762183313;30898.69101308958;53294;53678;53732;53791.38625841231;53918;402810;408337;411026;412487;413232;33338.33323333471;34083.82958085194;34155.82922085374;34168.65831341655;34189.82905085458;37576.43635345527;43839;43965;44070.77964610157;44263.55736442594;30443.847780760956;32170.839145804122;32546.51180232251;33289.83355083209;33310;27004.459910802067;31442.685573143975;31654.525182122747;32298.83850580826;32883;32183;32364.514532281562;32408.83795581007;32564.674353257113;33052.83473582713;24698.753012469646;24926.750732492445;29315.85342073276;29553.704462955095;30455.695443045286;22230.221942231943;22406.32781016572;22725.659115112954;22873.19943801959;22925.54148916979 04:55:59 INFO - PROCESS | 1655 | |2;jquery.html;384.9692024638029;398.0963213505343;415.6550063447339;420.5479109956796;440.9603135717785;12370;19754.802451975494;20174.39476815696;20616.453765967537;21000.579988400223;20057.59884802303;21550.353489395304;22015.669764953498;22332.8883355583;22430.775692243074;5697.6011679182475;6343.048542718595;6420.839479013039;6467.773627923024;6481.773137940173;6502.2197336319705;7307.963460182718;7308;7309.963450182769;7312;6952.99181618665;7125.786226413215;7205.459590530705;7207.38737207338;7310.963445182793;7128.679209435588;7153.463490238253;7182.533135346212;7233.819154521127;7240;6479.935200648028;7078.221395646527;7084.929150708478;7099.36105750485;7113.75101871432;24868.751312486824;25607.359816004748;25748.22755317325;25777.226683199347;26175.607365889526;3252.138183381382;3276.885309014197;3286.934261314784;3288.8355582221034;3290.2925870937866;14322.427102915872;14983.5612900663;15269.770953435707;15407.537773866801;16734.497965060946;1924.4150215701538;1938.0890981238936;1941.4078705994666;1947.8928658923753;1964.4106767969695;113736;114235;131935;144718;145998.4959185608;17085;20071.190033395338;22539.88730056339;22802.330864986565;23291.670832916574;40468;41113;41257.55598554036;41323.1735365291;41353.37969930453;10048.447335396477;10900.945495272632;10952.507137178687;11083.057940075023;11212.887871121347;8791.032986371494;8791.208791208694;8825.867611985825;9007.279417646572;9018.008019117891;10583.31208471447;10872.347659140476;10881.347119172875;10997.395143267036;11038.503267352988;4042.5244785653613;4081.9387709184384;4123.082766513586;4124.381342798604;4124.628783409507;980.475445636581;993.0516356879164;1003.8243307421172;1005.0351662404174;1021.7292417509366;16427.753583696252;19249.51876203078;20111.095000725003;20349.287774927805;20703.792962070187;853.6030745703154;985.1527686189871;1005.5575546759402;1022.4325499347784;1024.329064462778;9976.301658883809;10445.425501597334;10459.110975567162;10481.423521706227;10593.205509586813;630695;632781;634871.1282217981;636685;661679.6916015389;135081;135559;137215.31392342976;143100;143302;1172.460668092687;1179.292424545266;1200.609801814414;1201.7296108375372;1205.6684411786653;16975.320987160376;17420.738688919424;17481.45482174618;17599.120043998006;17837.643247135245;58783.412165879505;58946.70526647339;60207;60280;60372.69813650904;81057.18942810732;81446;83636;83739.5813020931;85740;9227.907720922705;10982.0665243452;10991.725206869893;11313.547458101584;11409.144314176636;11997.520099195934;12051.57819476314;12226.20529665569;12342.629721108382;12415.751684966432;10439.568672303814;10470.476476176009;10588.311759735592;10749.355038697391;10806.945965270123;10171.898281017095;10214.336068155546;10231.28381013322;10498.265121441425;10791.082757965662;9681.951590242004;11024.448777560929;11073.058790002618;11174.553017879194;11463.713407164887;11115.944420277847;11231.887681123084;11494.425278736197;11523.308601483937;11538.59614913474;9596.136347728738;10662.946685266834;10756.354618722902;11061.612843550438;11078.05836503874 04:55:59 INFO - PROCESS | 1655 | |3;mootools.html;1471.543821415362;1573.4571572807386;1585.9048457092572;1602.2389365051608;1606.5742578216773;9220.677276295331;10761.408122553257;10778.353298802067;10795.406252656101;10813.83779243311;10444.268901176902;10519.894801051987;10788.136949044077;10879.728006799814;10883.1837612179;2300.7584203658666;2338.4387746940697;2340.602097643396;2348.9060437582475;2350.4123969007746;1958.9118489667928;1982.871113377633;2348.9647655285185;2349.4126468382906;2352.6588644646517;2310.8844557772127;2329.324495896188;2332.265336419031;2339.6139636959883;2340.707411573553;2291.129370839087;2292.7248730152323;2315.143396943133;2317.073170731704;2319.6404557293645;1900.4013735673218;2328.9650655240184;2330.7552706965694;2331.5803155432013;2334.5447637710654;10751.247412681116;10843.403612801292;10845.240833141683;10849.077828384598;10880.836787448194;5490.505854473076;5649.491545760901;5656.151577263402;5661.886762264773;5675.489205971482;3297.851596678131;3394.1514621344663;3617.981910090459;3624.3838547446735;3626.5104210931713;1171.3908767440969;1183.1244878789635;1215.8297838302556;1225.3689349984677;1242.2546472116658;12346.81479777795;13513.256770877599;13893.027488075839;13912.37394317258;15017.098974061591;4438.423005009328;4589.059242855206;4603.516630753723;4607.650098449748;4622.375979242759;11364;11374.260673056226;11383.317000979967;11384.260023098472;11404.258723182966;4807.6394270429855;4990.451050384455;5026.623003274696;5026.84919452417;5569.693666848362;4282.35764635301;4827.565519103297;5028.245763135559;5215.452377500384;5242.580593552507;3647.1399586211223;3738.476613274144;3790.9431358529646;3793.506844110303;3797.810109494514;995.0944640377222;1011.3123076308034;1025.9384436933808;1030.9123724483352;1032.2258306270298;901.9413738107002;937.9765505862408;939.5865819039601;954.3271993244746;977.9364341317792;6280.591761535577;6346.8413289667205;6531.412172904462;6575.506836987245;6660.733570657119;965.8744363232735;988.4415305352453;990.217727994876;990.7275499237624;1005;3947.782871942071;3971.2057588481844;4029.8589549365634;4057.594240575978;4137.91724165515;13030.08789384734;13298.601041968757;13457.596272111852;13460.125091869193;13556.728865422834;10739.946300268604;13255.204687718768;13370.39833207508;13370.799438008438;13395.397207125703;9903.207743380512;9976.102150806608;10010.64962726301;10020.398776073458;10027.39835609851;6261.843453913689;6307.211598550181;6369.2484566744515;6504.642244676588;6542.443892269211;11614.593489227836;12077.939610301892;12087.153899226969;12095.39523023863;12112;10872.021518063413;11135.944320278346;12369.814452783396;12398;12400.19398739079;7893.210678932061;8842.248408885316;8894.42186257891;9058.36591438593;9081.409708368936;8291.253787159185;9970.451625160686;10002.949985250027;10009.099181073738;10026.64906728261;8508.61711222984;8647.913520864711;8754.562271886507;8763.60563774619;8799.824003520022;8091.06952700447;8135.30849877767;8210.83578328442;8269.917300826915;8287.544185069879;7635.923640763522;7657.808554785952;7742.109657389247;7777.650005749868;7789.454738168274;5619.2133101365025;5706.572007099568;5777.884442311214;5805.332386775575;5877.177195192762;4297.52727200014;5893.204417403767;5920.615160014585;5966.3735307793795;6050.183225264533 04:55:59 INFO - PROCESS | 1655 | |4;prototype.html;332.8931303416141;365.60514644184286;376.81347732872234;380.42745667770004;382.95644369094214;4562.475315338737;4646.930296045562;4727.598154156893;4936.975315123424;5089.938574877171;4370.836435964195;4550.544945505448;4806.327114204014;4970.602351811855;4972.925406118902;4020.1959608078428;4122.670691059557;4183.79081045948;4196.790160491979;4209.97895010526;3457.066592020153;3548.846624846922;4058.0463591056077;4089.018635527482;4112.046777780545;3685.2076803487244;4154.54590893188;4161.438205842218;4185.811638476261;4198.580141985793;3442.0362298556443;3550.242629898191;3865.362215234483;4097.8730849016465;4206.780033790197;3334.1831251343574;3451.6030656474327;3475.4786781982652;3808.1050953026015;3810.047488127968;3999.300122478555;4615.238485649864;4791.377120974251;4801.831935882227;4824.565789078964;4072.068110960104;4229.38673892287;4284.400183974246;4767.593559899838;4812.7352995585225;4396.922753925277;4794.650621195624;5309.309789727349;5333.919991200135;5368.865778355534;4057.3711074783455;4291.6566674665955;4310.224159651261;4325.913481730379;4397.714148580364;4959.668955590902;5484.970560892495;5505.073224371518;5665.716714164275;5785.334686511063;3549.0062782420964;4028.697847661437;4054.9391759123637;4203.789810509462;4448.266036104072;4498.752568608758;4531.796069176895;4533.116042371706;4543.818247270072;4556.577672569631;4008.498937632796;4455.819207909906;4594.839180628662;4785.928211076836;4845;4469.949561852962;5191.195364718475;5249.737513124329;5329.680219186784;5362.257266388439;1352.4454973460834;1364.433759989613;1497.1554047310199;1508.057464084947;1509.6301406155562;1042.7497400623795;1047.5704960965968;1127.261643623428;1134.9716257093473;1146.7878442488166;4599.05719327537;4738.891193418895;4945.530174633404;5028.642266588001;5041.899162016813;4839.185305510434;5354.732263386893;5469.596974435538;5557.944420555743;5597.44025597437;4098.836046558164;4734.810607575659;4748.501407352247;4903.705777653352;4974.452810190876;2473.8392004519646;2799.636047313877;2814.945090084209;2828.292926768308;2832.3768770870374;4793.784279707422;5304.552041173191;5635.323761148688;5660.603757736919;5674.290713660793;4801.95198048015;5307.920381194285;5561.972190139023;5579.38626751057;5682.801101961411;5101.387833460009;5398.541124004503;5458.2904222451625;5624.578156638187;5752.252207213036;4848.5636292733825;4989;5047.394312682502;5279.313689220377;5411.756470958738;4965.577925876341;5178.0679477694375;5206.505381988705;5413.83758487246;5448;4879.730925119837;5129.820456284012;5382.892342153056;5562.972185139049;5615.466530679579;4272.658187344943;4296.195597848973;4296.823384898486;4300.548442413501;4327.675424343124;4566.26939689648;5078.441371449211;5176.5246904631995;5191.792328306826;5385;4316.827326907014;4480.327950807275;4868.48880867518;5053.519915608012;5124.412171853191;4124.979375103106;4908.318760929303;4959.851204463872;4973.35346404965;5242.842714718565;4851.490593487774;5009.9248511271635;5151.599944037068;5171.431142574239;5199.906055896736;4561.885952851205;4941.591646380764;5108.744562771921;5208.3229180207845;5336.973315133399;4435.223835828652;4722.338872557913;4818.169095743595;5168.002558516127;5222.764975576184 04:55:59 INFO - PROCESS | 1655 | |5;yui.html;706.4419108903966;712.1454254894128;714.9535280206783;784.7606480023594;806.5362416610449;14223.928880355597;15167.241637918116;15210.467633632825;15215;15239.771403428944;13655.863441365584;14323.641908952255;14446.927765361159;14545.200013999225;14563.344649490771;938.2025278513261;955.1976339874504;956.364017928077;959.2230293462318;959.7984423271122;935.7520257131865;957.2150836314225;958.884933807944;960.0735290444719;974.4494360686225;1020.275604320933;1021.1728499915092;1021.954012069455;1022.2435397805607;1022.9386236825777;1014.9647359693146;1017.7048655889784;1017.7557386227326;1018.6638409324905;1020.4285600063988;755.4447481101386;755.9907523456137;756.5158298688843;757.0877093102853;757.8560073586001;14872.958892877503;15317.846821531753;15329.080255184614;15768.921155394264;15958.361665533364;13592.796108058386;13751.312434378242;13852.861471385258;13882.930585347009;14121.576352709333;9592.376495527767;10634.734131646694;10974.780504389948;11624.941875290653;11682.474288657031;3640.472131540912;3649.61679023704;3684.521012268415;3793.070697679059;3810.504634397538;105763;106471.46764266284;110299.44850275698;110541.44729276303;110595.34106988402;8410.537420441811;10550.419726915094;10732.678019659423;10740.946295268473;10917.344959302467;22530.549389012456;22819.543609127726;22939.42651433694;22988;23093.53812923732;7389.852202955911;7497.512661676974;7607.581583012988;7830.569318687527;7835.764927052198;4117.773522456294;4213.199492096492;4270.35944608305;4317.978410107929;4396.714213576107;3436.9484457733156;3528.7353448490953;3537.8407971640822;3538.363094642989;3549.396602577568;599.5772980049055;627.6798832595409;634.8000379880323;638.8115505925763;639.6481934935766;652.1739130434763;674.8549061951704;685.8114018644812;688.5386790850142;706.374858250452;8996.910030899739;9055.777470041592;9800.754981125529;10162;10225.181985441146;659.3011407907633;668.5153263883743;674.9628770417675;704.6441547018825;718.1274751177344;4580.862574122782;4782.067496838153;4929.367882226856;4930.464002854855;4947.348000616813;88743;93501.59747603792;93522;94351.52824235836;95844;83889.58055209684;85427;85585;86102;86712.5664371674;74287;74635.25364746392;76649.61675191588;77097;77941.83087253696;7186.6047367395295;9466.148046675833;9480.95259523698;9568.808623827623;9574.090461406155;38625.80687096546;48533.27200092072;48955;50088;51244.231336529236;55675.42911539417;56714.149287759894;63124.36875631185;64509.35490645221;66298;12732.108752387245;12827;12971.09202355826;13511;13565.59303220905;14330.49843255481;14338.713225735219;14372.28138593087;14386.792452830256;14526.644061084824;11528.59649912249;13514.864851351755;14088.839178717142;14198.929005354907;14207.005509614228;13145.624282362109;13208.471661133448;13688.589342319747;14138.858611414165;14410.927945360625;13062.869371306166;13208.801867971795;13506.459741610226;14095;14125.858741412865;10643.201759868196;10653.627123050655;10786.191035672513;10820.296680715728;11374.260673056226;8517.95741021291;10713.571457141627;10817.105841897068;10828.945855270673;10871.347719136877 04:55:59 INFO - PROCESS | 1655 | __end_tp_report 04:55:59 INFO - PROCESS | 1655 | __start_cc_report 04:55:59 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,2675 04:55:59 INFO - PROCESS | 1655 | __end_cc_report 04:55:59 INFO - PROCESS | 1655 | __startTimestamp1488718559887__endTimestamp 04:55:59 INFO - PROCESS | 1655 | 04:55:59 INFO - PROCESS | 1655 | ------- Summary: start ------- 04:55:59 INFO - PROCESS | 1655 | Number of tests: 6 04:55:59 INFO - PROCESS | 1655 | 04:55:59 INFO - PROCESS | 1655 | [#0] dojo.html Cycles:165 Average:5771.41 Median:6071.97 stddev:657.78 (10.8%) stddev-sans-first:624.78 04:55:59 INFO - PROCESS | 1655 | Values: 3071.8 3343.9 3347.0 3360.1 3406.5 5612.4 5656.0 5777.5 5923.7 5930.6 5665.1 5742.5 5750.9 5763.6 5767.0 5139.4 5187.4 5187.8 5227.1 5230.6 4364.7 5255.4 5269.8 5275.9 5290.0 5264.1 5264.4 5269.3 5278.5 5285.9 5130.2 5262.2 5281.8 5284.7 5290.5 4506.4 5103.9 5217.6 5219.5 5232.3 5988.6 6019.5 6032.1 6032.2 6035.8 6161.2 6179.8 6190.5 6194.5 6204.7 6140.6 6161.2 6209.2 6248.5 6251.5 5294.3 5804.7 5819.8 5827.2 5870.9 6200.6 6284.2 6316.3 6316.6 6322.9 6219.1 6238.3 6241.3 6249.2 6278.5 6213.7 6220.7 6231.1 6234.7 6250.5 6027.9 6130.4 6160.9 6181.7 6223.4 6180.8 6214.5 6216.8 6219.1 6230.7 5018.2 5068.1 5069.0 5073.0 5082.5 4387.2 4442.3 4466.9 4470.2 4504.1 5777.4 5793.5 5795.8 5813.6 5834.4 6205.6 6207.3 6219.0 6221.8 6222.1 5522.8 5534.3 5588.1 5739.5 5748.9 5443.4 5450.4 5451.6 5456.5 5471.0 6189.8 6262.2 6269.1 6288.6 6345.7 6256.2 6264.2 6270.0 6273.0 6276.8 6381.4 6391.7 6392.8 6394.8 6398.3 6103.8 6132.8 6299.9 6318.2 6327.7 6072.0 6247.3 6255.6 6261.8 6267.7 6042.8 6079.1 6097.0 6106.4 6109.2 6118.4 6159.6 6215.3 6233.3 6236.3 6084.7 6094.8 6098.5 6101.6 6128.0 6212.2 6250.4 6265.6 6268.0 6270.8 5812.9 5848.5 5905.9 5906.1 5908.9 04:55:59 INFO - PROCESS | 1655 | 04:55:59 INFO - PROCESS | 1655 | [#1] ext.html Cycles:180 Average:52036.60 Median:17766.73 stddev:99510.81 (560.1%) stddev-sans-first:99715.53 04:55:59 INFO - PROCESS | 1655 | Values: 775.1 797.1 863.2 873.5 874.9 31654.0 39532.2 39575.0 39711.8 39764.8 40833.0 40936.8 40966.4 41196.0 41252.0 7467.2 9262.9 9452.4 9459.8 9460.7 7508.4 7610.5 7610.8 7613.8 11050.0 9552.6 11276.9 11286.3 11294.4 11320.6 11196.7 11224.7 11248.0 11257.2 11262.4 7345.3 7482.9 10950.9 10986.1 11001.5 28227.0 28414.1 38170.0 38608.0 40613.0 3816.8 3818.0 3877.6 3885.2 3987.2 28765.9 28771.3 28793.7 29000.6 29790.9 3113.6 3142.4 3168.7 3234.6 3263.3 315397.0 317530.0 318970.0 319958.0 321629.4 50697.0 50749.7 50755.7 50819.0 50997.0 53505.2 53560.2 53585.7 53654.0 53684.7 13788.5 14107.9 14122.4 14127.4 14129.6 12001.6 12009.3 12019.7 12030.2 12034.2 12368.1 12701.6 12702.9 12772.3 12822.9 5287.5 5347.4 5352.8 5354.5 5371.8 1085.3 1123.9 1138.4 1162.7 1171.4 25030.0 26243.6 26378.2 26544.5 26573.5 1206.2 1208.4 1217.4 1248.7 1255.7 11747.0 13460.3 13830.7 13851.9 13912.0 392882.0 393873.0 395445.0 395734.0 397228.0 54996.7 55087.0 55096.0 55108.7 55116.0 1214.9 1374.3 1425.4 1426.4 1428.9 20515.7 21595.7 29801.3 30067.9 30898.7 53294.0 53678.0 53732.0 53791.4 53918.0 402810.0 408337.0 411026.0 412487.0 413232.0 33338.3 34083.8 34155.8 34168.7 34189.8 37576.4 43839.0 43965.0 44070.8 44263.6 30443.8 32170.8 32546.5 33289.8 33310.0 27004.5 31442.7 31654.5 32298.8 32883.0 32183.0 32364.5 32408.8 32564.7 33052.8 24698.8 24926.8 29315.9 29553.7 30455.7 22230.2 22406.3 22725.7 22873.2 22925.5 04:55:59 INFO - PROCESS | 1655 | 04:55:59 INFO - PROCESS | 1655 | [#2] jquery.html Cycles:180 Average:38811.60 Median:20261.84 stddev:106710.90 (526.7%) stddev-sans-first:106971.24 04:55:59 INFO - PROCESS | 1655 | Values: 385.0 398.1 415.7 420.5 441.0 12370.0 19754.8 20174.4 20616.5 21000.6 20057.6 21550.4 22015.7 22332.9 22430.8 5697.6 6343.0 6420.8 6467.8 6481.8 6502.2 7308.0 7308.0 7310.0 7312.0 6953.0 7125.8 7205.5 7207.4 7311.0 7128.7 7153.5 7182.5 7233.8 7240.0 6479.9 7078.2 7084.9 7099.4 7113.8 24868.8 25607.4 25748.2 25777.2 26175.6 3252.1 3276.9 3286.9 3288.8 3290.3 14322.4 14983.6 15269.8 15407.5 16734.5 1924.4 1938.1 1941.4 1947.9 1964.4 113736.0 114235.0 131935.0 144718.0 145998.5 17085.0 20071.2 22539.9 22802.3 23291.7 40468.0 41113.0 41257.6 41323.2 41353.4 10048.4 10900.9 10952.5 11083.1 11212.9 8791.0 8791.2 8825.9 9007.3 9018.0 10583.3 10872.3 10881.3 10997.4 11038.5 4042.5 4081.9 4123.1 4124.4 4124.6 980.5 993.1 1003.8 1005.0 1021.7 16427.8 19249.5 20111.1 20349.3 20703.8 853.6 985.2 1005.6 1022.4 1024.3 9976.3 10445.4 10459.1 10481.4 10593.2 630695.0 632781.0 634871.1 636685.0 661679.7 135081.0 135559.0 137215.3 143100.0 143302.0 1172.5 1179.3 1200.6 1201.7 1205.7 16975.3 17420.7 17481.5 17599.1 17837.6 58783.4 58946.7 60207.0 60280.0 60372.7 81057.2 81446.0 83636.0 83739.6 85740.0 9227.9 10982.1 10991.7 11313.5 11409.1 11997.5 12051.6 12226.2 12342.6 12415.8 10439.6 10470.5 10588.3 10749.4 10806.9 10171.9 10214.3 10231.3 10498.3 10791.1 9682.0 11024.4 11073.1 11174.6 11463.7 11115.9 11231.9 11494.4 11523.3 11538.6 9596.1 10662.9 10756.4 11061.6 11078.1 04:55:59 INFO - PROCESS | 1655 | 04:55:59 INFO - PROCESS | 1655 | [#3] mootools.html Cycles:180 Average:6473.98 Median:3346.00 stddev:4026.16 (120.3%) stddev-sans-first:4019.90 04:55:59 INFO - PROCESS | 1655 | Values: 1471.5 1573.5 1585.9 1602.2 1606.6 9220.7 10761.4 10778.4 10795.4 10813.8 10444.3 10519.9 10788.1 10879.7 10883.2 2300.8 2338.4 2340.6 2348.9 2350.4 1958.9 1982.9 2349.0 2349.4 2352.7 2310.9 2329.3 2332.3 2339.6 2340.7 2291.1 2292.7 2315.1 2317.1 2319.6 1900.4 2329.0 2330.8 2331.6 2334.5 10751.2 10843.4 10845.2 10849.1 10880.8 5490.5 5649.5 5656.2 5661.9 5675.5 3297.9 3394.2 3618.0 3624.4 3626.5 1171.4 1183.1 1215.8 1225.4 1242.3 12346.8 13513.3 13893.0 13912.4 15017.1 4438.4 4589.1 4603.5 4607.7 4622.4 11364.0 11374.3 11383.3 11384.3 11404.3 4807.6 4990.5 5026.6 5026.8 5569.7 4282.4 4827.6 5028.2 5215.5 5242.6 3647.1 3738.5 3790.9 3793.5 3797.8 995.1 1011.3 1025.9 1030.9 1032.2 901.9 938.0 939.6 954.3 977.9 6280.6 6346.8 6531.4 6575.5 6660.7 965.9 988.4 990.2 990.7 1005.0 3947.8 3971.2 4029.9 4057.6 4137.9 13030.1 13298.6 13457.6 13460.1 13556.7 10739.9 13255.2 13370.4 13370.8 13395.4 9903.2 9976.1 10010.6 10020.4 10027.4 6261.8 6307.2 6369.2 6504.6 6542.4 11614.6 12077.9 12087.2 12095.4 12112.0 10872.0 11135.9 12369.8 12398.0 12400.2 7893.2 8842.2 8894.4 9058.4 9081.4 8291.3 9970.5 10002.9 10009.1 10026.6 8508.6 8647.9 8754.6 8763.6 8799.8 8091.1 8135.3 8210.8 8269.9 8287.5 7635.9 7657.8 7742.1 7777.7 7789.5 5619.2 5706.6 5777.9 5805.3 5877.2 4297.5 5893.2 5920.6 5966.4 6050.2 04:55:59 INFO - PROCESS | 1655 | 04:55:59 INFO - PROCESS | 1655 | [#4] prototype.html Cycles:180 Average:4377.72 Median:4743.70 stddev:1218.32 (25.7%) stddev-sans-first:1183.31 04:55:59 INFO - PROCESS | 1655 | Values: 332.9 365.6 376.8 380.4 383.0 4562.5 4646.9 4727.6 4937.0 5089.9 4370.8 4550.5 4806.3 4970.6 4972.9 4020.2 4122.7 4183.8 4196.8 4210.0 3457.1 3548.8 4058.0 4089.0 4112.0 3685.2 4154.5 4161.4 4185.8 4198.6 3442.0 3550.2 3865.4 4097.9 4206.8 3334.2 3451.6 3475.5 3808.1 3810.0 3999.3 4615.2 4791.4 4801.8 4824.6 4072.1 4229.4 4284.4 4767.6 4812.7 4396.9 4794.7 5309.3 5333.9 5368.9 4057.4 4291.7 4310.2 4325.9 4397.7 4959.7 5485.0 5505.1 5665.7 5785.3 3549.0 4028.7 4054.9 4203.8 4448.3 4498.8 4531.8 4533.1 4543.8 4556.6 4008.5 4455.8 4594.8 4785.9 4845.0 4469.9 5191.2 5249.7 5329.7 5362.3 1352.4 1364.4 1497.2 1508.1 1509.6 1042.7 1047.6 1127.3 1135.0 1146.8 4599.1 4738.9 4945.5 5028.6 5041.9 4839.2 5354.7 5469.6 5557.9 5597.4 4098.8 4734.8 4748.5 4903.7 4974.5 2473.8 2799.6 2814.9 2828.3 2832.4 4793.8 5304.6 5635.3 5660.6 5674.3 4802.0 5307.9 5562.0 5579.4 5682.8 5101.4 5398.5 5458.3 5624.6 5752.3 4848.6 4989.0 5047.4 5279.3 5411.8 4965.6 5178.1 5206.5 5413.8 5448.0 4879.7 5129.8 5382.9 5563.0 5615.5 4272.7 4296.2 4296.8 4300.5 4327.7 4566.3 5078.4 5176.5 5191.8 5385.0 4316.8 4480.3 4868.5 5053.5 5124.4 4125.0 4908.3 4959.9 4973.4 5242.8 4851.5 5009.9 5151.6 5171.4 5199.9 4561.9 4941.6 5108.7 5208.3 5337.0 4435.2 4722.3 4818.2 5168.0 5222.8 04:55:59 INFO - PROCESS | 1655 | 04:55:59 INFO - PROCESS | 1655 | [#5] yui.html Cycles:180 Average:19851.59 Median:3667.07 stddev:28251.86 (770.4%) stddev-sans-first:28294.54 04:55:59 INFO - PROCESS | 1655 | Values: 706.4 712.1 715.0 784.8 806.5 14223.9 15167.2 15210.5 15215.0 15239.8 13655.9 14323.6 14446.9 14545.2 14563.3 938.2 955.2 956.4 959.2 959.8 935.8 957.2 958.9 960.1 974.4 1020.3 1021.2 1022.0 1022.2 1022.9 1015.0 1017.7 1017.8 1018.7 1020.4 755.4 756.0 756.5 757.1 757.9 14873.0 15317.8 15329.1 15768.9 15958.4 13592.8 13751.3 13852.9 13882.9 14121.6 9592.4 10634.7 10974.8 11624.9 11682.5 3640.5 3649.6 3684.5 3793.1 3810.5 105763.0 106471.5 110299.4 110541.4 110595.3 8410.5 10550.4 10732.7 10740.9 10917.3 22530.5 22819.5 22939.4 22988.0 23093.5 7389.9 7497.5 7607.6 7830.6 7835.8 4117.8 4213.2 4270.4 4318.0 4396.7 3436.9 3528.7 3537.8 3538.4 3549.4 599.6 627.7 634.8 638.8 639.6 652.2 674.9 685.8 688.5 706.4 8996.9 9055.8 9800.8 10162.0 10225.2 659.3 668.5 675.0 704.6 718.1 4580.9 4782.1 4929.4 4930.5 4947.3 88743.0 93501.6 93522.0 94351.5 95844.0 83889.6 85427.0 85585.0 86102.0 86712.6 74287.0 74635.3 76649.6 77097.0 77941.8 7186.6 9466.1 9481.0 9568.8 9574.1 38625.8 48533.3 48955.0 50088.0 51244.2 55675.4 56714.1 63124.4 64509.4 66298.0 12732.1 12827.0 12971.1 13511.0 13565.6 14330.5 14338.7 14372.3 14386.8 14526.6 11528.6 13514.9 14088.8 14198.9 14207.0 13145.6 13208.5 13688.6 14138.9 14410.9 13062.9 13208.8 13506.5 14095.0 14125.9 10643.2 10653.6 10786.2 10820.3 11374.3 8518.0 10713.6 10817.1 10828.9 10871.3 04:55:59 INFO - PROCESS | 1655 | -------- Summary: end -------- 04:55:59 INFO - PROCESS | 1655 | 04:56:00 INFO - TEST-INFO | 1655: exit 0 04:56:00 INFO - TEST-OK | dromaeo_css | took 1121868ms 04:56:00 INFO - TEST-START | kraken 04:56:00 INFO - operating with platform_type : mac_ 04:56:00 INFO - Initialising browser for kraken test... 04:56:00 INFO - TEST-INFO | started process 1660 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmpwOqipz/profile http://localhost:49245/getInfo.html) 04:56:03 INFO - PROCESS | 1660 | __metrics Screen width/height:1600/1200 04:56:03 INFO - PROCESS | 1660 | colorDepth:24 04:56:03 INFO - PROCESS | 1660 | Browser inner width/height: 1024/689 04:56:03 INFO - PROCESS | 1660 | __metrics 04:56:03 INFO - PROCESS | 1660 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:56:03 INFO - PROCESS | 1660 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:56:04 INFO - TEST-INFO | 1660: exit 0 04:56:04 INFO - Browser initialized. 04:56:04 INFO - Running cycle 1/1 for kraken test... 04:56:04 INFO - TEST-INFO | started process 1662 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/T/tmpwOqipz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:56:16 INFO - PROCESS | 1662 | RSS: Main: 232558592 04:56:16 INFO - PROCESS | 1662 | 04:56:19 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection) 04:56:20 INFO - PROCESS | 1662 | RSS: Main: 284430336 04:56:20 INFO - PROCESS | 1662 | 04:56:22 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-dft) 04:56:23 INFO - PROCESS | 1662 | RSS: Main: 287633408 04:56:23 INFO - PROCESS | 1662 | 04:56:26 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-fft) 04:56:27 INFO - PROCESS | 1662 | RSS: Main: 376672256 04:56:27 INFO - PROCESS | 1662 | 04:56:29 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator) 04:56:30 INFO - PROCESS | 1662 | RSS: Main: 280846336 04:56:30 INFO - PROCESS | 1662 | 04:56:32 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:56:32 INFO - PROCESS | 1662 | RSS: Main: 283787264 04:56:32 INFO - PROCESS | 1662 | 04:56:35 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom) 04:56:36 INFO - PROCESS | 1662 | RSS: Main: 325099520 04:56:36 INFO - PROCESS | 1662 | 04:56:39 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate) 04:56:40 INFO - PROCESS | 1662 | RSS: Main: 327020544 04:56:40 INFO - PROCESS | 1662 | 04:56:43 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial) 04:56:43 INFO - PROCESS | 1662 | RSS: Main: 327000064 04:56:43 INFO - PROCESS | 1662 | 04:56:45 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:56:46 INFO - PROCESS | 1662 | RSS: Main: 299298816 04:56:46 INFO - PROCESS | 1662 | 04:56:48 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:56:48 INFO - PROCESS | 1662 | RSS: Main: 304992256 04:56:48 INFO - PROCESS | 1662 | 04:56:50 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:56:51 INFO - PROCESS | 1662 | RSS: Main: 309977088 04:56:51 INFO - PROCESS | 1662 | 04:56:54 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:56:55 INFO - PROCESS | 1662 | RSS: Main: 323289088 04:56:55 INFO - PROCESS | 1662 | 04:56:58 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:56:58 INFO - PROCESS | 1662 | RSS: Main: 317632512 04:56:58 INFO - PROCESS | 1662 | 04:57:00 INFO - PROCESS | 1662 | Cycle 1(1): loaded http://localhost:49245/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49245/tests/kraken/driver.html?testName=ai-astar) 04:57:00 INFO - PROCESS | 1662 | RSS: Main: 362409984 04:57:00 INFO - PROCESS | 1662 | 04:57:00 INFO - PROCESS | 1662 | __start_tp_report 04:57:00 INFO - PROCESS | 1662 | _x_x_mozilla_page_load 04:57:00 INFO - PROCESS | 1662 | _x_x_mozilla_page_load_details 04:57:00 INFO - PROCESS | 1662 | |i|pagename|runs| 04:57:00 INFO - PROCESS | 1662 | |0;ai-astar;116;117;117;115;116;115;115;115;115;115 04:57:00 INFO - PROCESS | 1662 | |1;audio-beat-detection;132;110;108;146;112;109;110;108;130;110 04:57:00 INFO - PROCESS | 1662 | |2;audio-dft;185;185;195;186;179;185;184;184;180;183 04:57:00 INFO - PROCESS | 1662 | |3;audio-fft;79;61;60;91;60;58;61;64;76;61 04:57:00 INFO - PROCESS | 1662 | |4;audio-oscillator;91;71;90;71;70;69;85;71;68;83 04:57:00 INFO - PROCESS | 1662 | |5;imaging-gaussian-blur;87;88;89;90;116;87;92;88;86;86 04:57:00 INFO - PROCESS | 1662 | |6;imaging-darkroom;93;94;102;111;93;94;93;96;93;94 04:57:00 INFO - PROCESS | 1662 | |7;imaging-desaturate;83;105;128;81;86;86;83;84;82;86 04:57:00 INFO - PROCESS | 1662 | |8;json-parse-financial;65;62;61;61;62;61;61;63;62;61 04:57:00 INFO - PROCESS | 1662 | |9;json-stringify-tinderbox;54;65;60;62;63;59;57;57;58;59 04:57:00 INFO - PROCESS | 1662 | |10;stanford-crypto-aes;89;85;93;90;89;87;86;85;90;93 04:57:00 INFO - PROCESS | 1662 | |11;stanford-crypto-ccm;165;137;141;169;146;150;142;137;180;139 04:57:00 INFO - PROCESS | 1662 | |12;stanford-crypto-pbkdf2;172;171;169;171;170;170;177;172;174;221 04:57:00 INFO - PROCESS | 1662 | |13;stanford-crypto-sha256-iterative;67;66;67;68;67;67;66;64;62;67 04:57:00 INFO - PROCESS | 1662 | __end_tp_report 04:57:00 INFO - PROCESS | 1662 | __start_cc_report 04:57:00 INFO - PROCESS | 1662 | _x_x_mozilla_cycle_collect,2170 04:57:00 INFO - PROCESS | 1662 | __end_cc_report 04:57:00 INFO - PROCESS | 1662 | __startTimestamp1488718620948__endTimestamp 04:57:00 INFO - PROCESS | 1662 | 04:57:00 INFO - PROCESS | 1662 | ------- Summary: start ------- 04:57:00 INFO - PROCESS | 1662 | Number of tests: 14 04:57:00 INFO - PROCESS | 1662 | 04:57:00 INFO - PROCESS | 1662 | [#0] ai-astar Cycles:10 Average:115.60 Median:115.50 stddev:0.84 (0.7%) stddev-sans-first:0.88 04:57:00 INFO - PROCESS | 1662 | Values: 116.0 117.0 117.0 115.0 116.0 115.0 115.0 115.0 115.0 115.0 04:57:00 INFO - PROCESS | 1662 | 04:57:00 INFO - PROCESS | 1662 | [#1] audio-beat-detection Cycles:10 Average:117.50 Median:111.00 stddev:13.46 (12.1%) stddev-sans-first:13.21 04:57:00 INFO - PROCESS | 1662 | Values: 132.0 110.0 108.0 146.0 112.0 109.0 110.0 108.0 130.0 110.0 04:57:00 INFO - PROCESS | 1662 | 04:57:00 INFO - PROCESS | 1662 | [#2] audio-dft Cycles:10 Average:184.60 Median:185.00 stddev:4.30 (2.3%) stddev-sans-first:4.56 04:57:00 INFO - PROCESS | 1662 | Values: 185.0 185.0 195.0 186.0 179.0 185.0 184.0 184.0 180.0 183.0 04:57:00 INFO - PROCESS | 1662 | 04:57:00 INFO - PROCESS | 1662 | [#3] audio-fft Cycles:10 Average:67.10 Median:62.50 stddev:11.04 (17.7%) stddev-sans-first:10.84 04:57:00 INFO - PROCESS | 1662 | Values: 79.0 61.0 60.0 91.0 60.0 58.0 61.0 64.0 76.0 61.0 04:57:00 INFO - PROCESS | 1662 | 04:57:00 INFO - PROCESS | 1662 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:77.00 stddev:9.23 (12.0%) stddev-sans-first:8.26 04:57:00 INFO - PROCESS | 1662 | Values: 91.0 71.0 90.0 71.0 70.0 69.0 85.0 71.0 68.0 83.0 04:57:00 INFO - PROCESS | 1662 | 04:57:00 INFO - PROCESS | 1662 | [#5] imaging-gaussian-blur Cycles:10 Average:90.90 Median:88.00 stddev:9.01 (10.2%) stddev-sans-first:9.45 04:57:00 INFO - PROCESS | 1662 | Values: 87.0 88.0 89.0 90.0 116.0 87.0 92.0 88.0 86.0 86.0 04:57:00 INFO - PROCESS | 1662 | 04:57:00 INFO - PROCESS | 1662 | [#6] imaging-darkroom Cycles:10 Average:96.30 Median:93.50 stddev:5.85 (6.3%) stddev-sans-first:6.08 04:57:00 INFO - PROCESS | 1662 | Values: 93.0 94.0 102.0 111.0 93.0 94.0 93.0 96.0 93.0 94.0 04:57:00 INFO - PROCESS | 1662 | 04:57:00 INFO - PROCESS | 1662 | [#7] imaging-desaturate Cycles:10 Average:90.40 Median:83.50 stddev:14.89 (17.8%) stddev-sans-first:15.55 04:57:00 INFO - PROCESS | 1662 | Values: 83.0 105.0 128.0 81.0 86.0 86.0 83.0 84.0 82.0 86.0 04:57:00 INFO - PROCESS | 1662 | 04:57:00 INFO - PROCESS | 1662 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:62.00 stddev:1.29 (2.1%) stddev-sans-first:0.73 04:57:00 INFO - PROCESS | 1662 | Values: 65.0 62.0 61.0 61.0 62.0 61.0 61.0 63.0 62.0 61.0 04:57:00 INFO - PROCESS | 1662 | 04:57:00 INFO - PROCESS | 1662 | [#9] json-stringify-tinderbox Cycles:10 Average:59.40 Median:59.50 stddev:3.24 (5.4%) stddev-sans-first:2.78 04:57:00 INFO - PROCESS | 1662 | Values: 54.0 65.0 60.0 62.0 63.0 59.0 57.0 57.0 58.0 59.0 04:57:00 INFO - PROCESS | 1662 | 04:57:00 INFO - PROCESS | 1662 | [#10] stanford-crypto-aes Cycles:10 Average:88.70 Median:89.50 stddev:2.95 (3.3%) stddev-sans-first:3.12 04:57:00 INFO - PROCESS | 1662 | Values: 89.0 85.0 93.0 90.0 89.0 87.0 86.0 85.0 90.0 93.0 04:57:00 INFO - PROCESS | 1662 | 04:57:00 INFO - PROCESS | 1662 | [#11] stanford-crypto-ccm Cycles:10 Average:150.60 Median:148.00 stddev:15.28 (10.3%) stddev-sans-first:15.30 04:57:00 INFO - PROCESS | 1662 | Values: 165.0 137.0 141.0 169.0 146.0 150.0 142.0 137.0 180.0 139.0 04:57:00 INFO - PROCESS | 1662 | 04:57:00 INFO - PROCESS | 1662 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:176.70 Median:172.00 stddev:15.73 (9.1%) stddev-sans-first:16.60 04:57:00 INFO - PROCESS | 1662 | Values: 172.0 171.0 169.0 171.0 170.0 170.0 177.0 172.0 174.0 221.0 04:57:00 INFO - PROCESS | 1662 | 04:57:00 INFO - PROCESS | 1662 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:67.00 stddev:1.79 (2.7%) stddev-sans-first:1.87 04:57:00 INFO - PROCESS | 1662 | Values: 67.0 66.0 67.0 68.0 67.0 67.0 66.0 64.0 62.0 67.0 04:57:00 INFO - PROCESS | 1662 | -------- Summary: end -------- 04:57:00 INFO - PROCESS | 1662 | 04:57:01 INFO - TEST-INFO | 1662: exit 0 04:57:01 INFO - TEST-OK | kraken | took 61168ms 04:57:01 INFO - SUITE-END | took 1183s 04:57:02 INFO - Completed test suite (00:19:43) 04:57:02 INFO - javascript benchmark 04:57:02 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7519.166823633068, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3071.8003329783564, 3343.866245350186, 3346.9665303346965, 3360.143163493312, 3406.489026646003, 5612.354579223391, 5655.971720141393, 5777.537796976242, 5923.73343199556, 5930.5848590598625, 5665.065264231397, 5742.54059675226, 5750.856228594287, 5763.625364351315, 5767.048437007899, 5139.4346621871655, 5187.429382767892, 5187.766550505217, 5227.137522308814, 5230.633855630107, 4364.716293440932, 5255.448177941318, 5269.789208431658, 5275.920861187085, 5289.973550132244, 5264.1051021326275, 5264.447233040533, 5269.262303277545, 5278.47215278471, 5285.947140528603, 5130.20481825314, 5262.236975638511, 5281.841544753664, 5284.735763211843, 5290.497402746733, 4506.369108324837, 5103.923441148386, 5217.5565076968505, 5219.451957544441, 5232.293640358541, 5988.580799344048, 6019.518438524908, 6032.065029920369, 6032.245969253843, 6035.818925432244, 6161.19904412428, 6179.845503862394, 6190.535709821736, 6194.5044396448175, 6204.720787564525, 6140.60946423305, 6161.168242287279, 6209.16176316196, 6248.5313601480075, 6251.499880009588, 5294.311739473882, 5804.738786754606, 5819.825405237807, 5827.155062515996, 5870.882582348329, 6200.627962322275, 6284.214473190851, 6316.336784637547, 6316.589421687576, 6322.873542529123, 6219.129321894939, 6238.313785483593, 6241.282252540925, 6249.187605611241, 6278.466330361879, 6213.689315534205, 6220.720067596969, 6231.065340199007, 6234.688265586702, 6250.531210159165, 6027.8794424111275, 6130.409625092252, 6160.8767824643255, 6181.660008699565, 6223.408776166257, 6180.783672571439, 6214.533909956771, 6216.7824126155365, 6219.0982307566055, 6230.688465576703, 5018.222175562721, 5068.087744206005, 5069.0, 5073.010762901273, 5082.517160869711, 4387.2103021455805, 4442.333649952533, 4466.888327791831, 4470.173017991682, 4504.076664283814, 5777.422257774189, 5793.478586927196, 5795.797147099831, 5813.563982701315, 5834.387389324144, 6205.596636218631, 6207.286162091327, 6218.968905155445, 6221.844453888599, 6222.097795819581, 5522.779088836402, 5534.280543529396, 5588.1059030555725, 5739.540836733051, 5748.913766293509, 5443.401225865152, 5450.427705090988, 5451.645643033269, 5456.48163424474, 5470.972645136829, 6189.783357582463, 6262.1859158310035, 6269.090981807703, 6288.622682639057, 6345.650989195638, 6256.186695729526, 6264.21697287839, 6270.0, 6273.0, 6276.843078923063, 6381.425671689571, 6391.744330226739, 6392.808215753535, 6394.840128996812, 6398.264199617103, 6103.816885493442, 6132.753252973555, 6299.874002520016, 6318.241810982711, 6327.651979141191, 6071.969640151771, 6247.250329960434, 6255.593386429868, 6261.78083767066, 6267.655278959701, 6042.758289668364, 6079.148919151411, 6097.024476083805, 6106.419890110433, 6109.20580324555, 6118.375534461997, 6159.630422174684, 6215.316315205414, 6233.345498722569, 6236.314005459305, 6084.700952760976, 6094.847628809315, 6098.481629061579, 6101.60339577926, 6127.969360153349, 6212.24165341816, 6250.406211409909, 6265.592736472115, 6268.0, 6270.7805226816845, 5812.883742325214, 5848.53211743051, 5905.940940590539, 5906.1140828874295, 5908.852278693067], "value": 5727.571372830427, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [775.097011981042, 797.1231645190292, 863.1799790199308, 873.4671850171394, 874.855648817945, 31654.0, 39532.20935581287, 39575.0, 39711.80144099283, 39764.80117599415, 40833.0, 40936.79531602338, 40966.38550421739, 41196.0, 41252.0, 7467.178610352884, 9262.861057084148, 9452.432854028746, 9459.763505912339, 9460.716178514622, 7508.361789247921, 7610.467267291292, 7610.809729756773, 7613.771586852404, 11050.0, 9552.57013434397, 11276.943615281913, 11286.322820630747, 11294.378809165493, 11320.6037788677, 11196.66410007701, 11224.66326010221, 11248.0, 11257.211995160342, 11262.436878156059, 7345.338919497271, 7482.925170748332, 10950.945245273802, 10986.066184374338, 11001.504932277987, 28227.0, 28414.147575572766, 38170.045748856224, 38608.0, 40613.0, 3816.8091595420397, 3817.9618203817886, 3877.5734669186368, 3885.203533275672, 3987.2224916141363, 28765.856170719013, 28771.28071798201, 28793.712062879524, 29000.564991525145, 29790.851045744632, 3113.641931177921, 3142.355817057498, 3168.746500279972, 3234.6280177779386, 3263.331017141504, 315397.0, 317530.0, 318969.9999999977, 319958.0, 321629.3918530416, 50697.0, 50749.731256718136, 50755.73110672189, 50819.0, 50996.98006039933, 53505.1974220387, 53560.19659705029, 53585.73207134017, 53654.0, 53684.73157634187, 13788.517401890886, 14107.929460352838, 14122.364493597814, 14127.434902603985, 14129.57611271643, 12001.63995080149, 12009.279443233434, 12019.699507512207, 12030.218035827644, 12034.157608967289, 12368.134230603771, 12701.555445559361, 12702.872971270353, 12772.297523636104, 12822.9358853207, 5287.524122828964, 5347.438518955531, 5352.785888564414, 5354.491323324278, 5371.75827087782, 1085.3162507620307, 1123.9044681202026, 1138.4364739454024, 1162.65770223431, 1171.4377098992532, 25030.0, 26243.606345904827, 26378.194105949464, 26544.469110618065, 26573.468530629278, 1206.1617176062728, 1208.3837243005955, 1217.3852204636778, 1248.7252804383204, 1255.7300180461245, 11747.0, 13460.326983650779, 13830.723385532234, 13851.930740346435, 13912.0, 392882.0, 393873.0, 395445.0, 395734.0, 397228.0, 54996.725016374665, 55087.0, 55096.0, 55108.72445637746, 55116.0, 1214.884585964332, 1374.2853716067789, 1425.4369524037947, 1426.429428228696, 1428.9499867504796, 20515.692264615744, 21595.676064859355, 29801.25496862596, 30067.94762183313, 30898.69101308958, 53294.0, 53678.0, 53732.0, 53791.38625841231, 53918.0, 402810.0, 408337.0, 411026.0, 412487.0, 413232.0, 33338.33323333471, 34083.82958085194, 34155.82922085374, 34168.65831341655, 34189.82905085458, 37576.43635345527, 43839.0, 43965.0, 44070.77964610157, 44263.55736442594, 30443.847780760956, 32170.839145804122, 32546.51180232251, 33289.83355083209, 33310.0, 27004.459910802067, 31442.685573143975, 31654.525182122747, 32298.83850580826, 32883.0, 32183.0, 32364.514532281562, 32408.83795581007, 32564.674353257113, 33052.83473582713, 24698.753012469646, 24926.750732492445, 29315.85342073276, 29553.704462955095, 30455.695443045286, 22230.221942231943, 22406.32781016572, 22725.659115112954, 22873.19943801959, 22925.54148916979], "value": 18429.86568774535, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [384.9692024638029, 398.0963213505343, 415.6550063447339, 420.5479109956796, 440.9603135717785, 12370.0, 19754.802451975494, 20174.39476815696, 20616.453765967537, 21000.579988400223, 20057.59884802303, 21550.353489395304, 22015.669764953498, 22332.8883355583, 22430.775692243074, 5697.6011679182475, 6343.048542718595, 6420.839479013039, 6467.773627923024, 6481.773137940173, 6502.2197336319705, 7307.963460182718, 7308.0, 7309.963450182769, 7312.0, 6952.99181618665, 7125.786226413215, 7205.459590530705, 7207.38737207338, 7310.963445182793, 7128.679209435588, 7153.463490238253, 7182.533135346212, 7233.819154521127, 7240.0, 6479.935200648028, 7078.221395646527, 7084.929150708478, 7099.36105750485, 7113.75101871432, 24868.751312486824, 25607.359816004748, 25748.22755317325, 25777.226683199347, 26175.607365889526, 3252.138183381382, 3276.885309014197, 3286.934261314784, 3288.8355582221034, 3290.2925870937866, 14322.427102915872, 14983.5612900663, 15269.770953435707, 15407.537773866801, 16734.497965060946, 1924.4150215701538, 1938.0890981238936, 1941.4078705994666, 1947.8928658923753, 1964.4106767969695, 113736.0, 114235.0, 131935.0, 144718.0, 145998.4959185608, 17085.0, 20071.190033395338, 22539.88730056339, 22802.330864986565, 23291.670832916574, 40468.0, 41113.0, 41257.55598554036, 41323.1735365291, 41353.37969930453, 10048.447335396477, 10900.945495272632, 10952.507137178687, 11083.057940075023, 11212.887871121347, 8791.032986371494, 8791.208791208694, 8825.867611985825, 9007.279417646572, 9018.008019117891, 10583.31208471447, 10872.347659140476, 10881.347119172875, 10997.395143267036, 11038.503267352988, 4042.5244785653613, 4081.9387709184384, 4123.082766513586, 4124.381342798604, 4124.628783409507, 980.475445636581, 993.0516356879164, 1003.8243307421172, 1005.0351662404174, 1021.7292417509366, 16427.753583696252, 19249.51876203078, 20111.095000725003, 20349.287774927805, 20703.792962070187, 853.6030745703154, 985.1527686189871, 1005.5575546759402, 1022.4325499347784, 1024.329064462778, 9976.301658883809, 10445.425501597334, 10459.110975567162, 10481.423521706227, 10593.205509586813, 630695.0, 632781.0, 634871.1282217981, 636685.0, 661679.6916015389, 135081.0, 135559.0, 137215.31392342976, 143100.0, 143302.0, 1172.460668092687, 1179.292424545266, 1200.609801814414, 1201.7296108375372, 1205.6684411786653, 16975.320987160376, 17420.738688919424, 17481.45482174618, 17599.120043998006, 17837.643247135245, 58783.412165879505, 58946.70526647339, 60207.0, 60280.0, 60372.69813650904, 81057.18942810732, 81446.0, 83636.0, 83739.5813020931, 85740.0, 9227.907720922705, 10982.0665243452, 10991.725206869893, 11313.547458101584, 11409.144314176636, 11997.520099195934, 12051.57819476314, 12226.20529665569, 12342.629721108382, 12415.751684966432, 10439.568672303814, 10470.476476176009, 10588.311759735592, 10749.355038697391, 10806.945965270123, 10171.898281017095, 10214.336068155546, 10231.28381013322, 10498.265121441425, 10791.082757965662, 9681.951590242004, 11024.448777560929, 11073.058790002618, 11174.553017879194, 11463.713407164887, 11115.944420277847, 11231.887681123084, 11494.425278736197, 11523.308601483937, 11538.59614913474, 9596.136347728738, 10662.946685266834, 10756.354618722902, 11061.612843550438, 11078.05836503874], "value": 11406.725755923646, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1471.543821415362, 1573.4571572807386, 1585.9048457092572, 1602.2389365051608, 1606.5742578216773, 9220.677276295331, 10761.408122553257, 10778.353298802067, 10795.406252656101, 10813.83779243311, 10444.268901176902, 10519.894801051987, 10788.136949044077, 10879.728006799814, 10883.1837612179, 2300.7584203658666, 2338.4387746940697, 2340.602097643396, 2348.9060437582475, 2350.4123969007746, 1958.9118489667928, 1982.871113377633, 2348.9647655285185, 2349.4126468382906, 2352.6588644646517, 2310.8844557772127, 2329.324495896188, 2332.265336419031, 2339.6139636959883, 2340.707411573553, 2291.129370839087, 2292.7248730152323, 2315.143396943133, 2317.073170731704, 2319.6404557293645, 1900.4013735673218, 2328.9650655240184, 2330.7552706965694, 2331.5803155432013, 2334.5447637710654, 10751.247412681116, 10843.403612801292, 10845.240833141683, 10849.077828384598, 10880.836787448194, 5490.505854473076, 5649.491545760901, 5656.151577263402, 5661.886762264773, 5675.489205971482, 3297.851596678131, 3394.1514621344663, 3617.981910090459, 3624.3838547446735, 3626.5104210931713, 1171.3908767440969, 1183.1244878789635, 1215.8297838302556, 1225.3689349984677, 1242.2546472116658, 12346.81479777795, 13513.256770877599, 13893.027488075839, 13912.37394317258, 15017.098974061591, 4438.423005009328, 4589.059242855206, 4603.516630753723, 4607.650098449748, 4622.375979242759, 11364.0, 11374.260673056226, 11383.317000979967, 11384.260023098472, 11404.258723182966, 4807.6394270429855, 4990.451050384455, 5026.623003274696, 5026.84919452417, 5569.693666848362, 4282.35764635301, 4827.565519103297, 5028.245763135559, 5215.452377500384, 5242.580593552507, 3647.1399586211223, 3738.476613274144, 3790.9431358529646, 3793.506844110303, 3797.810109494514, 995.0944640377222, 1011.3123076308034, 1025.9384436933808, 1030.9123724483352, 1032.2258306270298, 901.9413738107002, 937.9765505862408, 939.5865819039601, 954.3271993244746, 977.9364341317792, 6280.591761535577, 6346.8413289667205, 6531.412172904462, 6575.506836987245, 6660.733570657119, 965.8744363232735, 988.4415305352453, 990.217727994876, 990.7275499237624, 1005.0, 3947.782871942071, 3971.2057588481844, 4029.8589549365634, 4057.594240575978, 4137.91724165515, 13030.08789384734, 13298.601041968757, 13457.596272111852, 13460.125091869193, 13556.728865422834, 10739.946300268604, 13255.204687718768, 13370.39833207508, 13370.799438008438, 13395.397207125703, 9903.207743380512, 9976.102150806608, 10010.64962726301, 10020.398776073458, 10027.39835609851, 6261.843453913689, 6307.211598550181, 6369.2484566744515, 6504.642244676588, 6542.443892269211, 11614.593489227836, 12077.939610301892, 12087.153899226969, 12095.39523023863, 12112.0, 10872.021518063413, 11135.944320278346, 12369.814452783396, 12398.0, 12400.19398739079, 7893.210678932061, 8842.248408885316, 8894.42186257891, 9058.36591438593, 9081.409708368936, 8291.253787159185, 9970.451625160686, 10002.949985250027, 10009.099181073738, 10026.64906728261, 8508.61711222984, 8647.913520864711, 8754.562271886507, 8763.60563774619, 8799.824003520022, 8091.06952700447, 8135.30849877767, 8210.83578328442, 8269.917300826915, 8287.544185069879, 7635.923640763522, 7657.808554785952, 7742.109657389247, 7777.650005749868, 7789.454738168274, 5619.2133101365025, 5706.572007099568, 5777.884442311214, 5805.332386775575, 5877.177195192762, 4297.52727200014, 5893.204417403767, 5920.615160014585, 5966.3735307793795, 6050.183225264533], "value": 4961.415354351985, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [332.8931303416141, 365.60514644184286, 376.81347732872234, 380.42745667770004, 382.95644369094214, 4562.475315338737, 4646.930296045562, 4727.598154156893, 4936.975315123424, 5089.938574877171, 4370.836435964195, 4550.544945505448, 4806.327114204014, 4970.602351811855, 4972.925406118902, 4020.1959608078428, 4122.670691059557, 4183.79081045948, 4196.790160491979, 4209.97895010526, 3457.066592020153, 3548.846624846922, 4058.0463591056077, 4089.018635527482, 4112.046777780545, 3685.2076803487244, 4154.54590893188, 4161.438205842218, 4185.811638476261, 4198.580141985793, 3442.0362298556443, 3550.242629898191, 3865.362215234483, 4097.8730849016465, 4206.780033790197, 3334.1831251343574, 3451.6030656474327, 3475.4786781982652, 3808.1050953026015, 3810.047488127968, 3999.300122478555, 4615.238485649864, 4791.377120974251, 4801.831935882227, 4824.565789078964, 4072.068110960104, 4229.38673892287, 4284.400183974246, 4767.593559899838, 4812.7352995585225, 4396.922753925277, 4794.650621195624, 5309.309789727349, 5333.919991200135, 5368.865778355534, 4057.3711074783455, 4291.6566674665955, 4310.224159651261, 4325.913481730379, 4397.714148580364, 4959.668955590902, 5484.970560892495, 5505.073224371518, 5665.716714164275, 5785.334686511063, 3549.0062782420964, 4028.697847661437, 4054.9391759123637, 4203.789810509462, 4448.266036104072, 4498.752568608758, 4531.796069176895, 4533.116042371706, 4543.818247270072, 4556.577672569631, 4008.498937632796, 4455.819207909906, 4594.839180628662, 4785.928211076836, 4845.0, 4469.949561852962, 5191.195364718475, 5249.737513124329, 5329.680219186784, 5362.257266388439, 1352.4454973460834, 1364.433759989613, 1497.1554047310199, 1508.057464084947, 1509.6301406155562, 1042.7497400623795, 1047.5704960965968, 1127.261643623428, 1134.9716257093473, 1146.7878442488166, 4599.05719327537, 4738.891193418895, 4945.530174633404, 5028.642266588001, 5041.899162016813, 4839.185305510434, 5354.732263386893, 5469.596974435538, 5557.944420555743, 5597.44025597437, 4098.836046558164, 4734.810607575659, 4748.501407352247, 4903.705777653352, 4974.452810190876, 2473.8392004519646, 2799.636047313877, 2814.945090084209, 2828.292926768308, 2832.3768770870374, 4793.784279707422, 5304.552041173191, 5635.323761148688, 5660.603757736919, 5674.290713660793, 4801.95198048015, 5307.920381194285, 5561.972190139023, 5579.38626751057, 5682.801101961411, 5101.387833460009, 5398.541124004503, 5458.2904222451625, 5624.578156638187, 5752.252207213036, 4848.5636292733825, 4989.0, 5047.394312682502, 5279.313689220377, 5411.756470958738, 4965.577925876341, 5178.0679477694375, 5206.505381988705, 5413.83758487246, 5448.0, 4879.730925119837, 5129.820456284012, 5382.892342153056, 5562.972185139049, 5615.466530679579, 4272.658187344943, 4296.195597848973, 4296.823384898486, 4300.548442413501, 4327.675424343124, 4566.26939689648, 5078.441371449211, 5176.5246904631995, 5191.792328306826, 5385.0, 4316.827326907014, 4480.327950807275, 4868.48880867518, 5053.519915608012, 5124.412171853191, 4124.979375103106, 4908.318760929303, 4959.851204463872, 4973.35346404965, 5242.842714718565, 4851.490593487774, 5009.9248511271635, 5151.599944037068, 5171.431142574239, 5199.906055896736, 4561.885952851205, 4941.591646380764, 5108.744562771921, 5208.3229180207845, 5336.973315133399, 4435.223835828652, 4722.338872557913, 4818.169095743595, 5168.002558516127, 5222.764975576184], "value": 4024.5670706716332, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [706.4419108903966, 712.1454254894128, 714.9535280206783, 784.7606480023594, 806.5362416610449, 14223.928880355597, 15167.241637918116, 15210.467633632825, 15215.0, 15239.771403428944, 13655.863441365584, 14323.641908952255, 14446.927765361159, 14545.200013999225, 14563.344649490771, 938.2025278513261, 955.1976339874504, 956.364017928077, 959.2230293462318, 959.7984423271122, 935.7520257131865, 957.2150836314225, 958.884933807944, 960.0735290444719, 974.4494360686225, 1020.275604320933, 1021.1728499915092, 1021.954012069455, 1022.2435397805607, 1022.9386236825777, 1014.9647359693146, 1017.7048655889784, 1017.7557386227326, 1018.6638409324905, 1020.4285600063988, 755.4447481101386, 755.9907523456137, 756.5158298688843, 757.0877093102853, 757.8560073586001, 14872.958892877503, 15317.846821531753, 15329.080255184614, 15768.921155394264, 15958.361665533364, 13592.796108058386, 13751.312434378242, 13852.861471385258, 13882.930585347009, 14121.576352709333, 9592.376495527767, 10634.734131646694, 10974.780504389948, 11624.941875290653, 11682.474288657031, 3640.472131540912, 3649.61679023704, 3684.521012268415, 3793.070697679059, 3810.504634397538, 105763.0, 106471.46764266284, 110299.44850275698, 110541.44729276303, 110595.34106988402, 8410.537420441811, 10550.419726915094, 10732.678019659423, 10740.946295268473, 10917.344959302467, 22530.549389012456, 22819.543609127726, 22939.42651433694, 22988.0, 23093.53812923732, 7389.852202955911, 7497.512661676974, 7607.581583012988, 7830.569318687527, 7835.764927052198, 4117.773522456294, 4213.199492096492, 4270.35944608305, 4317.978410107929, 4396.714213576107, 3436.9484457733156, 3528.7353448490953, 3537.8407971640822, 3538.363094642989, 3549.396602577568, 599.5772980049055, 627.6798832595409, 634.8000379880323, 638.8115505925763, 639.6481934935766, 652.1739130434763, 674.8549061951704, 685.8114018644812, 688.5386790850142, 706.374858250452, 8996.910030899739, 9055.777470041592, 9800.754981125529, 10162.0, 10225.181985441146, 659.3011407907633, 668.5153263883743, 674.9628770417675, 704.6441547018825, 718.1274751177344, 4580.862574122782, 4782.067496838153, 4929.367882226856, 4930.464002854855, 4947.348000616813, 88743.0, 93501.59747603792, 93522.0, 94351.52824235836, 95844.0, 83889.58055209684, 85427.0, 85585.0, 86102.0, 86712.5664371674, 74287.0, 74635.25364746392, 76649.61675191588, 77097.0, 77941.83087253696, 7186.6047367395295, 9466.148046675833, 9480.95259523698, 9568.808623827623, 9574.090461406155, 38625.80687096546, 48533.27200092072, 48955.0, 50088.0, 51244.231336529236, 55675.42911539417, 56714.149287759894, 63124.36875631185, 64509.35490645221, 66298.0, 12732.108752387245, 12827.0, 12971.09202355826, 13511.0, 13565.59303220905, 14330.49843255481, 14338.713225735219, 14372.28138593087, 14386.792452830256, 14526.644061084824, 11528.59649912249, 13514.864851351755, 14088.839178717142, 14198.929005354907, 14207.005509614228, 13145.624282362109, 13208.471661133448, 13688.589342319747, 14138.858611414165, 14410.927945360625, 13062.869371306166, 13208.801867971795, 13506.459741610226, 14095.0, 14125.858741412865, 10643.201759868196, 10653.627123050655, 10786.191035672513, 10820.296680715728, 11374.260673056226, 8517.95741021291, 10713.571457141627, 10817.105841897068, 10828.945855270673, 10871.347719136877], "value": 7516.155525764829, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1442.6999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 117.0, 117.0, 115.0, 116.0, 115.0, 115.0, 115.0, 115.0, 115.0], "value": 115.6, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 110.0, 108.0, 146.0, 112.0, 109.0, 110.0, 108.0, 130.0, 110.0], "value": 117.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 195.0, 186.0, 179.0, 185.0, 184.0, 184.0, 180.0, 183.0], "value": 184.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 61.0, 60.0, 91.0, 60.0, 58.0, 61.0, 64.0, 76.0, 61.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 71.0, 90.0, 71.0, 70.0, 69.0, 85.0, 71.0, 68.0, 83.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 89.0, 90.0, 116.0, 87.0, 92.0, 88.0, 86.0, 86.0], "value": 90.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 102.0, 111.0, 93.0, 94.0, 93.0, 96.0, 93.0, 94.0], "value": 96.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 105.0, 128.0, 81.0, 86.0, 86.0, 83.0, 84.0, 82.0, 86.0], "value": 90.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 61.0, 61.0, 62.0, 61.0, 61.0, 63.0, 62.0, 61.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 65.0, 60.0, 62.0, 63.0, 59.0, 57.0, 57.0, 58.0, 59.0], "value": 59.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 85.0, 93.0, 90.0, 89.0, 87.0, 86.0, 85.0, 90.0, 93.0], "value": 88.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [165.0, 137.0, 141.0, 169.0, 146.0, 150.0, 142.0, 137.0, 180.0, 139.0], "value": 150.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [172.0, 171.0, 169.0, 171.0, 170.0, 170.0, 177.0, 172.0, 174.0, 221.0], "value": 176.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 66.0, 67.0, 68.0, 67.0, 67.0, 66.0, 64.0, 62.0, 67.0], "value": 66.1, "unit": "score"}]}]} 04:57:02 INFO - Return code: 0 04:57:02 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:57:02 ERROR - # TBPL SUCCESS # 04:57:02 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:57:02 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:57:02 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:57:02 INFO - 2017-03-05 04:57:02.290 screenresolution[1666:11962] starting screenresolution argv=screenresolution get 04:57:02 INFO - 2017-03-05 04:57:02.292 screenresolution[1666:11962] Display 0: 1600x1200x32@60 04:57:02 INFO - 2017-03-05 04:57:02.299 screenresolution[1667:11965] starting screenresolution argv=screenresolution list 04:57:02 INFO - Available Modes on Display 0 04:57:02 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:57:02 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:57:02 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:57:02 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:57:02 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:57:02 INFO - Intel Iris: 04:57:02 INFO - Chipset Model: Intel Iris 04:57:02 INFO - Type: GPU 04:57:02 INFO - Bus: Built-In 04:57:02 INFO - VRAM (Dynamic, Max): 1536 MB 04:57:02 INFO - Vendor: Intel (0x8086) 04:57:02 INFO - Device ID: 0x0a2e 04:57:02 INFO - Revision ID: 0x0009 04:57:02 INFO - Displays: 04:57:02 INFO - Display: 04:57:02 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:57:02 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:57:02 INFO - Display Serial Number: 1600x1200 60 04:57:02 INFO - Main Display: Yes 04:57:02 INFO - Mirror: Off 04:57:02 INFO - Online: Yes 04:57:02 INFO - Rotation: Supported 04:57:02 INFO - Return code: 0 04:57:02 INFO - Running post-action listener: _resource_record_post_action 04:57:02 INFO - [mozharness: 2017-03-05 12:57:02.535746Z] Finished run-tests step (success) 04:57:02 INFO - Running post-run listener: _resource_record_post_run 04:57:02 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 32484352; Write bytes: 513661952; Read time: 196; Write time: 1595 04:57:02 INFO - TinderboxPrint: CPU usage
54.1% 04:57:02 INFO - TinderboxPrint: I/O read bytes / time
32,484,352 / 196 04:57:02 INFO - TinderboxPrint: I/O write bytes / time
513,661,952 / 1,595 04:57:02 INFO - TinderboxPrint: CPU idle
2,210.1 (45.9%) 04:57:02 INFO - TinderboxPrint: CPU system
959.8 (19.9%) 04:57:02 INFO - TinderboxPrint: CPU user
1,647.9 (34.2%) 04:57:02 INFO - TinderboxPrint: Swap in / out
238,288,896 / 0 04:57:02 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 202572288; Write bytes: 201154560; Read time: 15612; Write time: 434 04:57:02 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 31554560; Write bytes: 302660608; Read time: 184; Write time: 1128 04:57:03 INFO - Running post-run listener: _upload_blobber_files 04:57:03 INFO - Blob upload gear active. 04:57:03 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:57:03 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:57:03 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', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:57:03 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 Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:57:03 INFO - (blobuploader) - INFO - Open directory for files ... 04:57:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:57:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:57:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:04 INFO - (blobuploader) - INFO - Done attempting. 04:57:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:57:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:57:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:05 INFO - (blobuploader) - INFO - Done attempting. 04:57:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:57:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:06 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:57:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:06 INFO - (blobuploader) - INFO - Done attempting. 04:57:06 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:57:06 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:57:06 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:57:08 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:57:08 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:57:08 INFO - (blobuploader) - INFO - Done attempting. 04:57:08 INFO - (blobuploader) - INFO - Iteration through files over. 04:57:08 INFO - Return code: 0 04:57:08 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:57:08 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:57:08 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a38e23f0c7705ddb5ee016e0a5b5cbf120e0019c65bbb3378b0753400185944bbc1a8192a4b536186e0fdb171c4452ef987813bb5a03ebbb6dc8fefa83042674", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/298b13a411c9e019ca01d8c0fdb7ce230ac74d4c1b061d3ee4c52841d52dc2b20c86e8c73fd357bd833052477fb8ca7cda228ab10a9ad2e043d8f0dffb718404", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61f7c31ae82a625ffc7855d662b33519dbc219385874eadcb3ca0746c61c3b4f589f95381c125bde382261fcd73ee0a7b40dd27d762a499fb3e37a3b3bb122da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1c77119fe0c7b78bcae4b63012bceec490920a80956b411f882fea5110a78db2aba4fda386a606c3a3993dd47c20d6d8bb2d96a02ea0ba01b250e6de7e75a13"} 04:57:08 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:57:08 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:57:08 INFO - Contents: 04:57:08 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a38e23f0c7705ddb5ee016e0a5b5cbf120e0019c65bbb3378b0753400185944bbc1a8192a4b536186e0fdb171c4452ef987813bb5a03ebbb6dc8fefa83042674", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/298b13a411c9e019ca01d8c0fdb7ce230ac74d4c1b061d3ee4c52841d52dc2b20c86e8c73fd357bd833052477fb8ca7cda228ab10a9ad2e043d8f0dffb718404", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61f7c31ae82a625ffc7855d662b33519dbc219385874eadcb3ca0746c61c3b4f589f95381c125bde382261fcd73ee0a7b40dd27d762a499fb3e37a3b3bb122da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1c77119fe0c7b78bcae4b63012bceec490920a80956b411f882fea5110a78db2aba4fda386a606c3a3993dd47c20d6d8bb2d96a02ea0ba01b250e6de7e75a13"} 04:57:08 INFO - Running post-run listener: copy_logs_to_upload_dir 04:57:08 INFO - Copying logs to upload dir... 04:57:08 INFO - mkdir: /builds/slave/test/build/upload/logs 04:57:08 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.487155 ========= master_lag: 0.80 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-05 04:57:09.161727) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 04:57:09.166502) ========= 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.ge2FzDsmwh/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.ut0Fg3BR5C/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a38e23f0c7705ddb5ee016e0a5b5cbf120e0019c65bbb3378b0753400185944bbc1a8192a4b536186e0fdb171c4452ef987813bb5a03ebbb6dc8fefa83042674", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/298b13a411c9e019ca01d8c0fdb7ce230ac74d4c1b061d3ee4c52841d52dc2b20c86e8c73fd357bd833052477fb8ca7cda228ab10a9ad2e043d8f0dffb718404", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61f7c31ae82a625ffc7855d662b33519dbc219385874eadcb3ca0746c61c3b4f589f95381c125bde382261fcd73ee0a7b40dd27d762a499fb3e37a3b3bb122da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1c77119fe0c7b78bcae4b63012bceec490920a80956b411f882fea5110a78db2aba4fda386a606c3a3993dd47c20d6d8bb2d96a02ea0ba01b250e6de7e75a13"} build_url:https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011345 build_url: 'https://queue.taskcluster.net/v1/task/Y_lcUtSNROKrLNW7cnXd4Q/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/a38e23f0c7705ddb5ee016e0a5b5cbf120e0019c65bbb3378b0753400185944bbc1a8192a4b536186e0fdb171c4452ef987813bb5a03ebbb6dc8fefa83042674", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/298b13a411c9e019ca01d8c0fdb7ce230ac74d4c1b061d3ee4c52841d52dc2b20c86e8c73fd357bd833052477fb8ca7cda228ab10a9ad2e043d8f0dffb718404", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/61f7c31ae82a625ffc7855d662b33519dbc219385874eadcb3ca0746c61c3b4f589f95381c125bde382261fcd73ee0a7b40dd27d762a499fb3e37a3b3bb122da", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/e1c77119fe0c7b78bcae4b63012bceec490920a80956b411f882fea5110a78db2aba4fda386a606c3a3993dd47c20d6d8bb2d96a02ea0ba01b250e6de7e75a13"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-05 04:57:09.204522) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 04:57:09.204846) ========= 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.ge2FzDsmwh/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.ut0Fg3BR5C/Listeners TMPDIR=/var/folders/k_/0p5m47c95ynggg32ny3_mlwh00000w/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.005094 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-05 04:57:09.252755) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 04:57:09.253071) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-05 04:57:09.256417) ========= ========= Total master_lag: 0.95 =========