builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0351 starttime: 1486640987.5 results: success (0) buildid: 20170209022422 builduid: dd1381c013c5495ab38d92f9b7adaad1 revision: 70debab476881121ddfe92fc60c80cfae0a63bc7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 03:49:47.502393) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-02-09 03:49:47.502782) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 03:49:47.503066) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-02-09 03:49:47.530520) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 03:49:47.531069) ========= 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.cyyrTACCAJ/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.QKLCf1FEbt/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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-02-09 03:49:47-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 164M=0s 2017-02-09 03:49:47 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.147612 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 03:49:47.704026) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 03:49:47.704352) ========= 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.cyyrTACCAJ/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.QKLCf1FEbt/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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.031449 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 03:49:47.756591) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 03:49:47.756896) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 70debab476881121ddfe92fc60c80cfae0a63bc7 --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 70debab476881121ddfe92fc60c80cfae0a63bc7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.cyyrTACCAJ/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.QKLCf1FEbt/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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-02-09 03:49:47,864 truncating revision to first 12 chars 2017-02-09 03:49:47,864 Setting DEBUG logging. 2017-02-09 03:49:47,864 attempt 1/10 2017-02-09 03:49:47,864 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/70debab47688?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-02-09 03:49:48,569 unpacking tar archive at: mozilla-central-70debab47688/testing/mozharness/ program finished with exit code 0 elapsedTime=0.984976 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-02-09 03:49:48.766570) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 03:49:48.767080) ========= script_repo_revision: 70debab476881121ddfe92fc60c80cfae0a63bc7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-02-09 03:49:48.767829) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 03:49:48.768414) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-02-09 03:49:48.788418) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-09 03:49:48.788687) ========= /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.cyyrTACCAJ/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.QKLCf1FEbt/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 03:49:48 INFO - MultiFileLogger online at 20170209 03:49:48 in /builds/slave/test 03:49:48 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 03:49:48 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:49:48 INFO - {'append_to_log': False, 03:49:48 INFO - 'base_work_dir': '/builds/slave/test', 03:49:48 INFO - 'blob_upload_branch': 'Firefox', 03:49:48 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:49:48 INFO - 'branch': 'Firefox', 03:49:48 INFO - 'buildbot_json_path': 'buildprops.json', 03:49:48 INFO - 'config_files': ('talos/mac_config.py',), 03:49:48 INFO - 'default_actions': ('clobber', 03:49:48 INFO - 'read-buildbot-config', 03:49:48 INFO - 'download-and-extract', 03:49:48 INFO - 'populate-webroot', 03:49:48 INFO - 'create-virtualenv', 03:49:48 INFO - 'install', 03:49:48 INFO - 'run-tests'), 03:49:48 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:49:48 INFO - 'download_minidump_stackwalk': True, 03:49:48 INFO - 'download_symbols': 'ondemand', 03:49:48 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:49:48 INFO - 'tooltool.py': '/tools/tooltool.py', 03:49:48 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:49:48 INFO - '/tools/misc-python/virtualenv.py')}, 03:49:48 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:49:48 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:49:48 INFO - 'installer_path': 'installer.exe', 03:49:48 INFO - 'log_level': 'info', 03:49:48 INFO - 'log_name': 'talos', 03:49:48 INFO - 'log_to_console': True, 03:49:48 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:49:48 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:49:48 INFO - 'opt_config_files': (), 03:49:48 INFO - 'pip_index': False, 03:49:48 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:49:48 INFO - 'cmd': ('bash', 03:49:49 INFO - '-c', 03:49:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:49:49 INFO - 'enabled': True, 03:49:49 INFO - 'halt_on_failure': False, 03:49:49 INFO - 'name': 'check_screen_resolution'},), 03:49:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:49:49 INFO - 'cmd': ('bash', 03:49:49 INFO - '-c', 03:49:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:49:49 INFO - 'enabled': True, 03:49:49 INFO - 'halt_on_failure': False, 03:49:49 INFO - 'name': 'check_screen_resolution'},), 03:49:49 INFO - 'run_cmd_checks_enabled': True, 03:49:49 INFO - 'sps_profile': False, 03:49:49 INFO - 'sps_profile_interval': 0, 03:49:49 INFO - 'suite': 'dromaeojs', 03:49:49 INFO - 'system_bits': '32', 03:49:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:49:49 INFO - 'title': 't-yosemite-r7-0351', 03:49:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:49:49 INFO - 'use_talos_json': True, 03:49:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:49:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:49:49 INFO - 'work_dir': 'build'} 03:49:49 INFO - [mozharness: 2017-02-09 11:49:49.002651Z] Running clobber step. 03:49:49 INFO - Running pre-action listener: _resource_record_pre_action 03:49:49 INFO - Running main action method: clobber 03:49:49 INFO - rmtree: /builds/slave/test/build 03:49:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:49:51 INFO - Running post-action listener: _resource_record_post_action 03:49:51 INFO - [mozharness: 2017-02-09 11:49:51.395723Z] Finished clobber step (success) 03:49:51 INFO - [mozharness: 2017-02-09 11:49:51.395877Z] Running read-buildbot-config step. 03:49:51 INFO - Running pre-action listener: _resource_record_pre_action 03:49:51 INFO - Running main action method: read_buildbot_config 03:49:51 INFO - Using buildbot properties: 03:49:51 INFO - { 03:49:51 INFO - "project": "", 03:49:51 INFO - "product": "firefox", 03:49:51 INFO - "script_repo_revision": "production", 03:49:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:49:51 INFO - "repository": "", 03:49:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:49:51 INFO - "buildid": "20170209022422", 03:49:51 INFO - "pgo_build": "False", 03:49:51 INFO - "basedir": "/builds/slave/test", 03:49:51 INFO - "buildnumber": 83, 03:49:51 INFO - "slavename": "t-yosemite-r7-0351", 03:49:51 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 03:49:51 INFO - "platform": "yosemite_r7", 03:49:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:49:51 INFO - "branch": "mozilla-central", 03:49:51 INFO - "repo_path": "mozilla-central", 03:49:51 INFO - "revision": "70debab476881121ddfe92fc60c80cfae0a63bc7", 03:49:51 INFO - "stage_platform": "macosx64", 03:49:51 INFO - "builduid": "dd1381c013c5495ab38d92f9b7adaad1", 03:49:51 INFO - "slavebuilddir": "test" 03:49:51 INFO - } 03:49:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 03:49:51 INFO - Running post-action listener: _resource_record_post_action 03:49:51 INFO - [mozharness: 2017-02-09 11:49:51.401663Z] Finished read-buildbot-config step (success) 03:49:51 INFO - [mozharness: 2017-02-09 11:49:51.401904Z] Running download-and-extract step. 03:49:51 INFO - Running pre-action listener: _resource_record_pre_action 03:49:51 INFO - Running main action method: download_and_extract 03:49:51 INFO - mkdir: /builds/slave/test/build/tests 03:49: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')]} 03:49:51 INFO - trying https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 03:49:51 INFO - Downloading https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/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 03:49:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/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 03:49:52 INFO - Downloaded 1199 bytes. 03:49:52 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 03:49:52 INFO - Using the following test package requirements: 03:49:52 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 03:49:52 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:49:52 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 03:49:52 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:49:52 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 03:49:52 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:49:52 INFO - u'jsshell-mac.zip'], 03:49:52 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:49:52 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 03:49:52 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 03:49:52 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:49:52 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 03:49:52 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:49:52 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 03:49:52 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:49:52 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 03:49:52 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:49:52 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 03:49:52 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:49:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 03:49:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:49:52 INFO - Fetch https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 03:49:53 INFO - Expected file size: 34939684 03:49:53 INFO - Obtained file size: 34939684 03:50:00 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 03:50:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 03:50:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:50:00 INFO - Fetch https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 03:50:01 INFO - Expected file size: 34939684 03:50:01 INFO - Obtained file size: 34939684 03:50:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 03:50:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:50:08 INFO - Fetch https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 03:50:09 INFO - Expected file size: 14403454 03:50:09 INFO - Obtained file size: 14403454 03:50:09 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:09 INFO - trying https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:50:09 INFO - Downloading https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 03:50:09 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/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 03:50:11 INFO - Downloaded 70303680 bytes. 03:50:11 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:50:11 INFO - mkdir: /builds/slave/test/properties 03:50:11 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:50:11 INFO - Writing to file /builds/slave/test/properties/build_url 03:50:11 INFO - Contents: 03:50:11 INFO - build_url:https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:50:12 INFO - Running post-action listener: _resource_record_post_action 03:50:12 INFO - Running post-action listener: set_extra_try_arguments 03:50:12 INFO - [mozharness: 2017-02-09 11:50:12.466273Z] Finished download-and-extract step (success) 03:50:12 INFO - [mozharness: 2017-02-09 11:50:12.466434Z] Running populate-webroot step. 03:50:12 INFO - Running pre-action listener: _resource_record_pre_action 03:50:12 INFO - Running main action method: populate_webroot 03:50:12 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:50:12 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:50:12 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:50:12 INFO - '--tppagecycles', 03:50:12 INFO - '7'], 03:50:12 INFO - 'tests': ['tsvgm']}}, 03:50:12 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:50:12 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:50:12 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:50:12 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:50:12 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:50:12 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:50:12 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:50:12 INFO - 'talos_options': ['--disable-e10s'], 03:50:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:12 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:50:12 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:50:12 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:50:12 INFO - 'talos_options': ['--disable-e10s'], 03:50:12 INFO - 'tests': ['damp', 'tps']}, 03:50:12 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:50:12 INFO - 'tests': ['damp', 'tps']}, 03:50:12 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:50:12 INFO - 'tests': ['dromaeo_dom']}, 03:50:12 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:50:12 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:50:12 INFO - 'tests': ['basic_compositor_video']}, 03:50:12 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:50:12 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:50:12 INFO - 'tests': ['a11yr', 03:50:12 INFO - 'ts_paint', 03:50:12 INFO - 'tpaint', 03:50:12 INFO - 'sessionrestore', 03:50:12 INFO - 'sessionrestore_no_auto_restore', 03:50:12 INFO - 'tabpaint']}, 03:50:12 INFO - 'other-e10s': {'tests': ['a11yr', 03:50:12 INFO - 'ts_paint', 03:50:12 INFO - 'tpaint', 03:50:12 INFO - 'sessionrestore', 03:50:12 INFO - 'sessionrestore_no_auto_restore', 03:50:12 INFO - 'tabpaint']}, 03:50:12 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:50:12 INFO - 'ts_paint', 03:50:12 INFO - 'tpaint', 03:50:12 INFO - 'sessionrestore', 03:50:12 INFO - 'sessionrestore_no_auto_restore', 03:50:12 INFO - 'tabpaint']}, 03:50:12 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:50:12 INFO - 'ts_paint', 03:50:12 INFO - 'tpaint', 03:50:12 INFO - 'sessionrestore', 03:50:12 INFO - 'sessionrestore_no_auto_restore', 03:50:12 INFO - 'tabpaint']}, 03:50:12 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:50:12 INFO - 'tests': ['a11yr', 03:50:12 INFO - 'ts_paint', 03:50:12 INFO - 'tpaint', 03:50:12 INFO - 'sessionrestore', 03:50:12 INFO - 'sessionrestore_no_auto_restore', 03:50:12 INFO - 'tabpaint']}, 03:50:12 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:50:12 INFO - 'tests': ['a11yr', 03:50:12 INFO - 'ts_paint', 03:50:12 INFO - 'tpaint', 03:50:12 INFO - 'sessionrestore', 03:50:12 INFO - 'sessionrestore_no_auto_restore', 03:50:12 INFO - 'tabpaint']}, 03:50:12 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:50:12 INFO - 'tests': ['tsvgx', 03:50:12 INFO - 'tsvgr_opacity', 03:50:12 INFO - 'tart', 03:50:12 INFO - 'tscrollx', 03:50:12 INFO - 'cart', 03:50:12 INFO - 'tsvg_static']}, 03:50:12 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:50:12 INFO - 'tsvgr_opacity', 03:50:12 INFO - 'tart', 03:50:12 INFO - 'tscrollx', 03:50:12 INFO - 'cart', 03:50:12 INFO - 'tsvg_static']}, 03:50:12 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:50:12 INFO - 'talos_options': ['--disable-e10s'], 03:50:12 INFO - 'tests': ['tp5o']}, 03:50:12 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:50:12 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:50:12 INFO - 'talos_options': ['--disable-e10s', 03:50:12 INFO - '--xperf_path', 03:50:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:12 INFO - 'tests': ['tp5n']}, 03:50:12 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:50:12 INFO - 'talos_options': ['--xperf_path', 03:50:12 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:50:12 INFO - 'tests': ['tp5n']}}, 03:50:12 INFO - 'talos.zip': {'path': '', 03:50:12 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:50:12 INFO - Running post-action listener: _resource_record_post_action 03:50:12 INFO - [mozharness: 2017-02-09 11:50:12.483100Z] Finished populate-webroot step (success) 03:50:12 INFO - [mozharness: 2017-02-09 11:50:12.483198Z] Running create-virtualenv step. 03:50:12 INFO - Running pre-action listener: _resource_record_pre_action 03:50:12 INFO - Running main action method: create_virtualenv 03:50:12 INFO - Creating virtualenv /builds/slave/test/build/venv 03:50:12 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 03:50:12 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:50:12 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:50:12 INFO - Using real prefix '/tools/python27' 03:50:12 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:50:13 INFO - Installing distribute.............................................................................................................................................................................................done. 03:50:16 INFO - Installing pip.................done. 03:50:16 INFO - Return code: 0 03:50:16 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:50:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:50:16 INFO - Reading from file tmpfile_stdout 03:50:16 INFO - Output received: 03:50:16 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) 03:50:16 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:16 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 0x10ad8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4ac98080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab69d30>, '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 0x10aa90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5ebe8>, '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.cyyrTACCAJ/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.QKLCf1FEbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 03:50:16 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 03:50:16 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 03:50:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cyyrTACCAJ/Render', 03:50:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:16 INFO - 'HOME': '/Users/cltbld', 03:50:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:16 INFO - 'LOGNAME': 'cltbld', 03:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:16 INFO - 'MOZ_NO_REMOTE': '1', 03:50:16 INFO - 'NO_EM_RESTART': '1', 03:50:16 INFO - 'PAGER': '/bin/cat', 03:50:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:16 INFO - 'PWD': '/builds/slave/test', 03:50:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:16 INFO - 'SHELL': '/bin/bash', 03:50:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKLCf1FEbt/Listeners', 03:50:16 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 03:50:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:16 INFO - 'USER': 'cltbld', 03:50:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:16 INFO - 'XPC_FLAGS': '0x0', 03:50:16 INFO - 'XPC_SERVICE_NAME': '0', 03:50:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:16 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 03:50:16 INFO - Cleaning up... 03:50:16 INFO - Return code: 0 03:50:16 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:16 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 0x10ad8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4ac98080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab69d30>, '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 0x10aa90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5ebe8>, '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.cyyrTACCAJ/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.QKLCf1FEbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 03:50:16 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 03:50:16 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 03:50:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cyyrTACCAJ/Render', 03:50:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:16 INFO - 'HOME': '/Users/cltbld', 03:50:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:16 INFO - 'LOGNAME': 'cltbld', 03:50:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:16 INFO - 'MOZ_NO_REMOTE': '1', 03:50:16 INFO - 'NO_EM_RESTART': '1', 03:50:16 INFO - 'PAGER': '/bin/cat', 03:50:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:16 INFO - 'PWD': '/builds/slave/test', 03:50:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:16 INFO - 'SHELL': '/bin/bash', 03:50:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKLCf1FEbt/Listeners', 03:50:16 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 03:50:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:16 INFO - 'USER': 'cltbld', 03:50:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:16 INFO - 'XPC_FLAGS': '0x0', 03:50:16 INFO - 'XPC_SERVICE_NAME': '0', 03:50:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:16 INFO - Downloading/unpacking psutil>=3.1.1 03:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:50:20 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:20 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:20 INFO - Installing collected packages: psutil 03:50:20 INFO - Running setup.py install for psutil 03:50:20 INFO - building 'psutil._psutil_osx' extension 03:50:20 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 03:50:21 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 03:50:21 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 03:50:21 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 03:50:21 INFO - building 'psutil._psutil_posix' extension 03:50:21 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 03:50:21 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:50:21 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:50:21 INFO - ^ 03:50:21 INFO - 1 warning generated. 03:50:21 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 03:50:21 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:50:21 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:50:21 INFO - Successfully installed psutil 03:50:21 INFO - Cleaning up... 03:50:21 INFO - Return code: 0 03:50:21 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:21 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 0x10ad8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4ac98080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab69d30>, '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 0x10aa90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5ebe8>, '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.cyyrTACCAJ/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.QKLCf1FEbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 03:50:21 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 03:50:21 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 03:50:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cyyrTACCAJ/Render', 03:50:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:21 INFO - 'HOME': '/Users/cltbld', 03:50:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:21 INFO - 'LOGNAME': 'cltbld', 03:50:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:21 INFO - 'MOZ_NO_REMOTE': '1', 03:50:21 INFO - 'NO_EM_RESTART': '1', 03:50:21 INFO - 'PAGER': '/bin/cat', 03:50:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:21 INFO - 'PWD': '/builds/slave/test', 03:50:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:21 INFO - 'SHELL': '/bin/bash', 03:50:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKLCf1FEbt/Listeners', 03:50:21 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 03:50:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:21 INFO - 'USER': 'cltbld', 03:50:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:21 INFO - 'XPC_FLAGS': '0x0', 03:50:21 INFO - 'XPC_SERVICE_NAME': '0', 03:50:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:21 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:50:21 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 03:50:21 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 03:50:21 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 03:50:21 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 03:50:21 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 03:50:21 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 03:50:24 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:50:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:50:24 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:50:24 INFO - Installing collected packages: mozsystemmonitor 03:50:24 INFO - Running setup.py install for mozsystemmonitor 03:50:24 INFO - Successfully installed mozsystemmonitor 03:50:24 INFO - Cleaning up... 03:50:24 INFO - Return code: 0 03:50:24 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:50:24 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')]} 03:50:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:24 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')]} 03:50:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:24 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 0x10ad8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4ac98080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab69d30>, '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 0x10aa90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5ebe8>, '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.cyyrTACCAJ/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.QKLCf1FEbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 03:50:24 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 03:50:24 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 03:50:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cyyrTACCAJ/Render', 03:50:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:24 INFO - 'HOME': '/Users/cltbld', 03:50:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:24 INFO - 'LOGNAME': 'cltbld', 03:50:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:24 INFO - 'MOZ_NO_REMOTE': '1', 03:50:24 INFO - 'NO_EM_RESTART': '1', 03:50:24 INFO - 'PAGER': '/bin/cat', 03:50:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:24 INFO - 'PWD': '/builds/slave/test', 03:50:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:24 INFO - 'SHELL': '/bin/bash', 03:50:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKLCf1FEbt/Listeners', 03:50:24 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 03:50:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:24 INFO - 'USER': 'cltbld', 03:50:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:24 INFO - 'XPC_FLAGS': '0x0', 03:50:24 INFO - 'XPC_SERVICE_NAME': '0', 03:50:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:25 INFO - Downloading/unpacking jsonschema==2.5.1 03:50:25 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 03:50:25 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 03:50:25 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 03:50:25 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 03:50:25 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 03:50:25 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 03:50:27 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:50:27 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:28 INFO - Downloading functools32-3.2.3-2.tar.gz 03:50:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:50:28 INFO - warning: no files found matching '*.txt' 03:50:28 INFO - no previously-included directories found matching 'build' 03:50:28 INFO - no previously-included directories found matching 'dist' 03:50:28 INFO - no previously-included directories found matching '.git*' 03:50:28 INFO - Installing collected packages: jsonschema, functools32 03:50:28 INFO - Running setup.py install for functools32 03:50:28 INFO - warning: no files found matching '*.txt' 03:50:28 INFO - no previously-included directories found matching 'build' 03:50:28 INFO - no previously-included directories found matching 'dist' 03:50:28 INFO - no previously-included directories found matching '.git*' 03:50:28 INFO - Successfully installed jsonschema functools32 03:50:28 INFO - Cleaning up... 03:50:28 INFO - Return code: 0 03:50:28 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:50: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')]} 03:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50: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')]} 03:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50: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', '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 0x10ad8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4ac98080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab69d30>, '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 0x10aa90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5ebe8>, '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.cyyrTACCAJ/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.QKLCf1FEbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 03:50: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:50: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 functools32==3.2.3-2 03:50:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cyyrTACCAJ/Render', 03:50:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:28 INFO - 'HOME': '/Users/cltbld', 03:50:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:28 INFO - 'LOGNAME': 'cltbld', 03:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:28 INFO - 'MOZ_NO_REMOTE': '1', 03:50:28 INFO - 'NO_EM_RESTART': '1', 03:50:28 INFO - 'PAGER': '/bin/cat', 03:50:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:28 INFO - 'PWD': '/builds/slave/test', 03:50:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:28 INFO - 'SHELL': '/bin/bash', 03:50:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKLCf1FEbt/Listeners', 03:50:28 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 03:50:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:28 INFO - 'USER': 'cltbld', 03:50:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:28 INFO - 'XPC_FLAGS': '0x0', 03:50:28 INFO - 'XPC_SERVICE_NAME': '0', 03:50:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:28 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:50:28 INFO - Cleaning up... 03:50:28 INFO - Return code: 0 03:50:28 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:50: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')]} 03:50:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50: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')]} 03:50:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50: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', '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 0x10ad8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4ac98080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab69d30>, '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 0x10aa90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5ebe8>, '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.cyyrTACCAJ/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.QKLCf1FEbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 03:50: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:50: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 blobuploader==1.2.4 03:50:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cyyrTACCAJ/Render', 03:50:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:28 INFO - 'HOME': '/Users/cltbld', 03:50:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:28 INFO - 'LOGNAME': 'cltbld', 03:50:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:28 INFO - 'MOZ_NO_REMOTE': '1', 03:50:28 INFO - 'NO_EM_RESTART': '1', 03:50:28 INFO - 'PAGER': '/bin/cat', 03:50:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:28 INFO - 'PWD': '/builds/slave/test', 03:50:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:28 INFO - 'SHELL': '/bin/bash', 03:50:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKLCf1FEbt/Listeners', 03:50:28 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 03:50:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:28 INFO - 'USER': 'cltbld', 03:50:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:28 INFO - 'XPC_FLAGS': '0x0', 03:50:28 INFO - 'XPC_SERVICE_NAME': '0', 03:50:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:29 INFO - Downloading/unpacking blobuploader==1.2.4 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50:31 INFO - Downloading blobuploader-1.2.4.tar.gz 03:50:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:50:31 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:31 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:31 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:50:31 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:50:31 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:50:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:50:32 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:50:32 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 03:50:32 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 03:50:32 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 03:50:32 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 03:50:32 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 03:50:32 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 03:50:32 INFO - Downloading docopt-0.6.1.tar.gz 03:50:32 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:50:33 INFO - Installing collected packages: blobuploader, requests, docopt 03:50:33 INFO - Running setup.py install for blobuploader 03:50:33 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:50:33 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:50:33 INFO - Running setup.py install for requests 03:50:33 INFO - Running setup.py install for docopt 03:50:33 INFO - Successfully installed blobuploader requests docopt 03:50:33 INFO - Cleaning up... 03:50:33 INFO - Return code: 0 03:50:33 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:50:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:33 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 0x10ad8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4ac98080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab69d30>, '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 0x10aa90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5ebe8>, '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.cyyrTACCAJ/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.QKLCf1FEbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 03:50:33 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 03:50:33 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 03:50:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cyyrTACCAJ/Render', 03:50:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:33 INFO - 'HOME': '/Users/cltbld', 03:50:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:33 INFO - 'LOGNAME': 'cltbld', 03:50:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:33 INFO - 'MOZ_NO_REMOTE': '1', 03:50:33 INFO - 'NO_EM_RESTART': '1', 03:50:33 INFO - 'PAGER': '/bin/cat', 03:50:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:33 INFO - 'PWD': '/builds/slave/test', 03:50:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:33 INFO - 'SHELL': '/bin/bash', 03:50:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKLCf1FEbt/Listeners', 03:50:33 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 03:50:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:33 INFO - 'USER': 'cltbld', 03:50:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:33 INFO - 'XPC_FLAGS': '0x0', 03:50:33 INFO - 'XPC_SERVICE_NAME': '0', 03:50:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:50:34 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-Nkuisg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:50:34 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-CtzDoB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:50:34 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-iybLqy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:50:34 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-6hKCUr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:50:34 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-vs0m0m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:50:34 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-hPpRTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:50:34 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-0em6r8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:50:34 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-XJdJBB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:50:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:50:34 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-GLTnQP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:50:35 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-_8KfQc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:50:35 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-SfvcMk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:50:35 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-BZztBT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:50:35 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-_uSF3V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:50:35 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-l3Womx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:35 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-mARU4Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:50:35 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-dMLIJ3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:50:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:50:35 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-a7XbQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:50:35 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:50:35 INFO - Running setup.py install for manifestparser 03:50:36 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:50:36 INFO - Running setup.py install for mozcrash 03:50:36 INFO - Running setup.py install for mozdebug 03:50:36 INFO - Running setup.py install for mozdevice 03:50:36 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:50:36 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:50:36 INFO - Running setup.py install for mozfile 03:50:36 INFO - Running setup.py install for mozhttpd 03:50:36 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:50:36 INFO - Running setup.py install for mozinfo 03:50:36 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:50:36 INFO - Running setup.py install for mozInstall 03:50:37 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:50:37 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:50:37 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:50:37 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:50:37 INFO - Running setup.py install for mozleak 03:50:37 INFO - Running setup.py install for mozlog 03:50:37 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:50:37 INFO - Running setup.py install for moznetwork 03:50:37 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:50:37 INFO - Running setup.py install for mozprocess 03:50:37 INFO - Running setup.py install for mozprofile 03:50:37 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:50:37 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:50:37 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:50:37 INFO - Running setup.py install for mozrunner 03:50:37 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:50:38 INFO - Running setup.py install for mozscreenshot 03:50:38 INFO - Running setup.py install for moztest 03:50:38 INFO - Running setup.py install for mozversion 03:50:38 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:50:38 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:50:38 INFO - Cleaning up... 03:50:38 INFO - Return code: 0 03:50:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50:38 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')]} 03:50:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:38 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')]} 03:50:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:38 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 0x10ad8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4ac98080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab69d30>, '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 0x10aa90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5ebe8>, '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.cyyrTACCAJ/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.QKLCf1FEbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 03:50:38 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 03:50:38 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 03:50:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cyyrTACCAJ/Render', 03:50:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:38 INFO - 'HOME': '/Users/cltbld', 03:50:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:38 INFO - 'LOGNAME': 'cltbld', 03:50:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:38 INFO - 'MOZ_NO_REMOTE': '1', 03:50:38 INFO - 'NO_EM_RESTART': '1', 03:50:38 INFO - 'PAGER': '/bin/cat', 03:50:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:38 INFO - 'PWD': '/builds/slave/test', 03:50:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:38 INFO - 'SHELL': '/bin/bash', 03:50:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKLCf1FEbt/Listeners', 03:50:38 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 03:50:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:38 INFO - 'USER': 'cltbld', 03:50:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:38 INFO - 'XPC_FLAGS': '0x0', 03:50:38 INFO - 'XPC_SERVICE_NAME': '0', 03:50:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:50:38 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-Q89qM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:50:38 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)) 03:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:50:38 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-zf4sRG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:50:38 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)) 03:50:38 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:50:38 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-juyDso-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:50:39 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)) 03:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:50:39 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-kDC7hU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:50:39 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)) 03:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:50:39 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-Lnfond-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:50:39 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)) 03:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:50:39 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-tBURkD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:50:39 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)) 03:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:50:39 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-COEjrW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:50:39 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)) 03:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:50:39 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-EiTtTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:50:39 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)) 03:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:50:39 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-sXKGpz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:50:39 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)) 03:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:50:39 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-yT8CYz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:50:39 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)) 03:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:50:39 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-CwvknO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:50:39 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)) 03:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:50:39 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-TErl8l-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:50:39 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 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)) 03:50:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:50:40 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-FXfjb_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:50:40 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)) 03:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:50:40 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-PgWOmn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:50:40 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)) 03:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:40 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-XQZYyh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:50:40 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)) 03:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:50:40 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-GWP6w6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:50:40 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)) 03:50:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:50:40 INFO - Running setup.py (path:/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/pip-65h3D0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:50:40 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)) 03:50:40 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)) 03:50:40 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)) 03:50:40 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)) 03:50:40 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)) 03:50:40 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)) 03:50:40 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50: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 03:50:43 INFO - Downloading blessings-1.6.tar.gz 03:50:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:50:43 INFO - Installing collected packages: blessings 03:50:43 INFO - Running setup.py install for blessings 03:50:43 INFO - Successfully installed blessings 03:50:43 INFO - Cleaning up... 03:50:43 INFO - Return code: 0 03:50:43 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:50:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:50:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:50:43 INFO - Reading from file tmpfile_stdout 03:50:43 INFO - Current package versions: 03:50:43 INFO - blessings == 1.6 03:50:43 INFO - blobuploader == 1.2.4 03:50:43 INFO - docopt == 0.6.1 03:50:43 INFO - functools32 == 3.2.3-2 03:50:43 INFO - jsonschema == 2.5.1 03:50:43 INFO - manifestparser == 1.1 03:50:43 INFO - mozInstall == 1.12 03:50:43 INFO - mozcrash == 1.0 03:50:43 INFO - mozdebug == 0.1 03:50:43 INFO - mozdevice == 0.49 03:50:43 INFO - mozfile == 1.2 03:50:43 INFO - mozhttpd == 0.7 03:50:43 INFO - mozinfo == 0.9 03:50:43 INFO - mozleak == 0.1 03:50:43 INFO - mozlog == 3.4 03:50:43 INFO - moznetwork == 0.27 03:50:43 INFO - mozprocess == 0.24 03:50:43 INFO - mozprofile == 0.28 03:50:43 INFO - mozrunner == 6.13 03:50:43 INFO - mozscreenshot == 0.1 03:50:43 INFO - mozsystemmonitor == 0.3 03:50:43 INFO - moztest == 0.8 03:50:43 INFO - mozversion == 1.4 03:50:43 INFO - psutil == 3.1.1 03:50:43 INFO - requests == 1.2.3 03:50:43 INFO - wsgiref == 0.1.2 03:50:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:50:43 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')]} 03:50:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:43 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')]} 03:50:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:44 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 0x10ad8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4ac98080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab69d30>, '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 0x10aa90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5ebe8>, '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.cyyrTACCAJ/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.QKLCf1FEbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 03:50:44 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 03:50:44 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 03:50:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cyyrTACCAJ/Render', 03:50:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:44 INFO - 'HOME': '/Users/cltbld', 03:50:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:44 INFO - 'LOGNAME': 'cltbld', 03:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:44 INFO - 'MOZ_NO_REMOTE': '1', 03:50:44 INFO - 'NO_EM_RESTART': '1', 03:50:44 INFO - 'PAGER': '/bin/cat', 03:50:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:44 INFO - 'PWD': '/builds/slave/test', 03:50:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:44 INFO - 'SHELL': '/bin/bash', 03:50:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKLCf1FEbt/Listeners', 03:50:44 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 03:50:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:44 INFO - 'USER': 'cltbld', 03:50:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:44 INFO - 'XPC_FLAGS': '0x0', 03:50:44 INFO - 'XPC_SERVICE_NAME': '0', 03:50:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:44 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)) 03:50:44 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)) 03:50:44 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)) 03:50:44 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)) 03:50:44 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)) 03:50:44 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)) 03:50:44 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)) 03:50:44 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)) 03:50:44 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)) 03:50:44 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)) 03:50:44 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)) 03:50:44 INFO - Cleaning up... 03:50:44 INFO - Return code: 0 03:50:44 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:50: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')]} 03:50:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:50:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50: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')]} 03:50:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:50:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:50:44 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 0x10ad8bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ad8e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ffc4ac98080>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ab69d30>, '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 0x10aa90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5ebe8>, '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.cyyrTACCAJ/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.QKLCf1FEbt/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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 03:50:44 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 03:50:44 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 03:50:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cyyrTACCAJ/Render', 03:50:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:50:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:50:44 INFO - 'HOME': '/Users/cltbld', 03:50:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:50:44 INFO - 'LOGNAME': 'cltbld', 03:50:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:50:44 INFO - 'MOZ_NO_REMOTE': '1', 03:50:44 INFO - 'NO_EM_RESTART': '1', 03:50:44 INFO - 'PAGER': '/bin/cat', 03:50:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:50:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:50:44 INFO - 'PWD': '/builds/slave/test', 03:50:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:50:44 INFO - 'SHELL': '/bin/bash', 03:50:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKLCf1FEbt/Listeners', 03:50:44 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 03:50:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:50:44 INFO - 'USER': 'cltbld', 03:50:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:50:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:50:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:50:44 INFO - 'XPC_FLAGS': '0x0', 03:50:44 INFO - 'XPC_SERVICE_NAME': '0', 03:50:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:50:45 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:50:45 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:50:45 INFO - Cleaning up... 03:50:45 INFO - Return code: 0 03:50:45 INFO - Running post-action listener: _resource_record_post_action 03:50:45 INFO - Running post-action listener: _start_resource_monitoring 03:50:45 INFO - Starting resource monitoring. 03:50:45 INFO - [mozharness: 2017-02-09 11:50:45.173500Z] Finished create-virtualenv step (success) 03:50:45 INFO - [mozharness: 2017-02-09 11:50:45.174437Z] Running install step. 03:50:45 INFO - Running pre-action listener: _resource_record_pre_action 03:50:45 INFO - Running main action method: install 03:50:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:50:45 INFO - Reading from file tmpfile_stdout 03:50:45 INFO - Detecting whether we're running mozinstall >=1.0... 03:50:45 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:50:45 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:50:45 INFO - Reading from file tmpfile_stdout 03:50:45 INFO - Output received: 03:50:45 INFO - Usage: mozinstall [options] installer 03:50:45 INFO - Options: 03:50:45 INFO - -h, --help show this help message and exit 03:50:45 INFO - -d DEST, --destination=DEST 03:50:45 INFO - Directory to install application into. [default: 03:50:45 INFO - "/builds/slave/test"] 03:50:45 INFO - --app=APP Application being installed. [default: firefox] 03:50:45 INFO - mkdir: /builds/slave/test/build/application 03:50:45 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'] 03:50:45 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 03:51:07 INFO - Reading from file tmpfile_stdout 03:51:07 INFO - Output received: 03:51:07 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:51:07 INFO - Running post-action listener: _resource_record_post_action 03:51:07 INFO - [mozharness: 2017-02-09 11:51:07.360096Z] Finished install step (success) 03:51:07 INFO - [mozharness: 2017-02-09 11:51:07.360219Z] Running run-tests step. 03:51:07 INFO - Running pre-action listener: _resource_record_pre_action 03:51:07 INFO - Running main action method: run_tests 03:51:07 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:51:07 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:51:07 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:51:07 INFO - 2017-02-09 03:51:07.374 screenresolution[1624:7303] starting screenresolution argv=screenresolution get 03:51:07 INFO - 2017-02-09 03:51:07.377 screenresolution[1624:7303] Display 0: 1600x1200x32@60 03:51:07 INFO - 2017-02-09 03:51:07.383 screenresolution[1625:7305] starting screenresolution argv=screenresolution list 03:51:07 INFO - Available Modes on Display 0 03:51:07 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:51:07 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:51:07 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:51:07 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:51:07 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:51:07 INFO - Intel Iris: 03:51:07 INFO - Chipset Model: Intel Iris 03:51:07 INFO - Type: GPU 03:51:07 INFO - Bus: Built-In 03:51:07 INFO - VRAM (Dynamic, Max): 1536 MB 03:51:07 INFO - Vendor: Intel (0x8086) 03:51:07 INFO - Device ID: 0x0a2e 03:51:07 INFO - Revision ID: 0x0009 03:51:07 INFO - Displays: 03:51:07 INFO - Display: 03:51:07 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:51:07 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:51:07 INFO - Display Serial Number: 1600x1200 60 03:51:07 INFO - Main Display: Yes 03:51:07 INFO - Mirror: Off 03:51:07 INFO - Online: Yes 03:51:07 INFO - Rotation: Supported 03:51:07 INFO - Return code: 0 03:51:07 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:51:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:51:07 INFO - Python 2.7.3 03:51:07 INFO - Return code: 0 03:51:07 INFO - grabbing minidump binary from tooltool 03:51:07 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')]} 03:51:07 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 0x10ab69d30>, '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 0x10aa90db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ab5ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:51:07 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 03:51:07 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 03:51:07 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 03:51:07 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:51:07 INFO - Return code: 0 03:51:07 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:51:07 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:51:07 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:51:07 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:51:07 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:51:07 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0351', '--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 03:51:07 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/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0351 --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 03:51:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.cyyrTACCAJ/Render', 03:51:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:51:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:51:07 INFO - 'HOME': '/Users/cltbld', 03:51:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:51:07 INFO - 'LOGNAME': 'cltbld', 03:51:07 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:51:07 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:51:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:51:07 INFO - 'MOZ_NO_REMOTE': '1', 03:51:07 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:51:07 INFO - 'NO_EM_RESTART': '1', 03:51:07 INFO - 'PAGER': '/bin/cat', 03:51:07 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:51:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:51:07 INFO - 'PWD': '/builds/slave/test', 03:51:07 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:51:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:51:07 INFO - 'SHELL': '/bin/bash', 03:51:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.QKLCf1FEbt/Listeners', 03:51:07 INFO - 'TMPDIR': '/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/', 03:51:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:51:07 INFO - 'USER': 'cltbld', 03:51:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:51:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:51:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:51:07 INFO - 'XPC_FLAGS': '0x0', 03:51:07 INFO - 'XPC_SERVICE_NAME': '0', 03:51:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:51:07 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/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0351', '--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 03:51:07 INFO - mozversion application_buildid: 20170209022422 03:51:07 INFO - mozversion application_changeset: 70debab476881121ddfe92fc60c80cfae0a63bc7 03:51:07 INFO - mozversion application_display_name: Nightly 03:51:07 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:51:07 INFO - mozversion application_name: Firefox 03:51:07 INFO - mozversion application_remotingname: firefox 03:51:07 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:51:07 INFO - mozversion application_vendor: Mozilla 03:51:07 INFO - mozversion application_version: 54.0a1 03:51:07 INFO - mozversion platform_buildid: 20170209022422 03:51:07 INFO - mozversion platform_changeset: 70debab476881121ddfe92fc60c80cfae0a63bc7 03:51:07 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:51:07 INFO - mozversion platform_version: 54.0a1 03:51:07 INFO - using testdate: 1486641067 03:51:07 INFO - actual date: 1486641067 03:51:07 INFO - starting webserver on 'localhost:49238' 03:51:07 INFO - SUITE-START | Running 2 tests 03:51:07 INFO - TEST-START | dromaeo_css 03:51:07 INFO - operating with platform_type : mac_ 03:51:07 INFO - Initialising browser for dromaeo_css test... 03:51:07 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/tmpOBFGof/profile http://localhost:49238/getInfo.html) 03:51:10 INFO - PROCESS | 1635 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 03:51:10 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 03:51:10 INFO - PROCESS | 1635 | colorDepth:24 03:51:10 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 03:51:10 INFO - PROCESS | 1635 | __metrics 03:51:10 INFO - PROCESS | 1635 | 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" 03:51:10 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:51:11 INFO - TEST-INFO | 1635: exit 0 03:51:11 INFO - Browser initialized. 03:51:11 INFO - Running cycle 1/1 for dromaeo_css test... 03:51:11 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/tmpOBFGof/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:51:23 INFO - PROCESS | 1637 | RSS: Main: 236961792 03:51:23 INFO - PROCESS | 1637 | 03:54:26 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49238/tests/dromaeo/cssquery-ext.html) 03:54:28 INFO - PROCESS | 1637 | RSS: Main: 404373504 03:54:28 INFO - PROCESS | 1637 | 03:56:12 INFO - PROCESS | 1637 | ************************* 03:56:12 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 03:56:12 INFO - PROCESS | 1637 | 03:56:12 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:56:12 INFO - PROCESS | 1637 | Full stack: 03:56:12 INFO - PROCESS | 1637 | ************************* 03:57:31 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-ext.html (next: http://localhost:49238/tests/dromaeo/cssquery-jquery.html) 03:57:32 INFO - PROCESS | 1637 | RSS: Main: 372019200 03:57:32 INFO - PROCESS | 1637 | 04:00:34 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49238/tests/dromaeo/cssquery-mootools.html) 04:00:35 INFO - PROCESS | 1637 | RSS: Main: 344346624 04:00:35 INFO - PROCESS | 1637 | 04:03:37 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49238/tests/dromaeo/cssquery-prototype.html) 04:03:38 INFO - PROCESS | 1637 | RSS: Main: 367063040 04:03:38 INFO - PROCESS | 1637 | 04:06:41 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49238/tests/dromaeo/cssquery-yui.html) 04:06:42 INFO - PROCESS | 1637 | RSS: Main: 338264064 04:06:42 INFO - PROCESS | 1637 | 04:09:45 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49238/tests/dromaeo/cssquery-yui.html (next: http://localhost:49238/tests/dromaeo/cssquery-dojo.html) 04:09:45 INFO - PROCESS | 1637 | RSS: Main: 512290816 04:09:45 INFO - PROCESS | 1637 | 04:09:45 INFO - PROCESS | 1637 | __start_tp_report 04:09:45 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 04:09:45 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 04:09:45 INFO - PROCESS | 1637 | |i|pagename|runs| 04:09:45 INFO - PROCESS | 1637 | |0;dojo.html;3257.9185520361993;3266.9346613067737;3275.9181020474493;3295.983520082399;3339.8163101029436;5271.15661494161;5360.678359298445;5447.645903016301;5517.144842549406;5537.169424586309;4698.694584851991;5259.237410575464;5436.537894278991;5480.095784195603;5484.478974497426;4622.9768851155695;4946.084974279752;4977.776000080005;4996.77514511846;5129.179331306992;5116.1814109742445;5131.332926719521;5133.435322114565;5145;5150.433452320261;4880.170371036932;4888.169011268093;4905.994271174436;5070.112730272206;5127.897442051175;4972.129877271463;4998.300237966688;5040.243963405482;5053.343065401511;5097.847064588032;4947.604191664658;4960.975195124038;4999.025190087934;5001.024800163969;5061.114304996648;5309.070912590281;5445;5449.291592093042;5466.508014278734;5481.369642491085;5771.278590176228;5836.328822185418;5852.4440178183;5898.4101589840675;5900.114982752579;6026.638401695912;6074.848128796772;6076.240469941257;6077.088436734481;6121.510279177655;5575.275214222166;5576.553875689976;5582.274304340491;5588.21764952907;5594.860128496779;5927.496162826122;6135.110408990671;6143.692815359214;6143.692815359214;6147.907781383283;5754.539636829044;5782.132680098019;5872.706364681749;5882.588218824641;5976.462118409364;6095.8476038098515;6099.9085013724825;6105.8473538161015;6110.083487476914;6112.694365281718;5915.142304365843;6004.969975150097;6009.248843894513;6044.909326360108;6045.667488288098;5741.712914354265;5800.477956983892;5801.88396232073;5969.2240008799445;6018.7291571878495;4869.63477739171;4878.219484882473;4881.609471242292;4885.706857588485;4918.680285781413;3702.851885924587;4351.608355248043;4352.651787856964;4362.607365337135;4385.6710746694125;5301.575873930076;5367.060764366221;5367.3827509836865;5481.260029895992;5524.779008839681;5988.820335389945;6034.24571928509;6037.607555508878;6090.086487026892;6134.601250918676;5425.996190704732;5473.507384335429;5490.450954904558;5495.945040549624;5497.862553436196;5131;5270.288511051036;5273.604479664041;5278.868028299324;5307.601929855199;5076.873078172927;5372.683692495286;5906.822795316061;6123.526657168292;6147.170132032118;5794.768209271582;6011.188489553854;6023.909641355471;6047.637141771508;6064.06007068905;6062.938985677577;6119.015143218386;6160.845978850564;6203.534734894811;6234.37656234391;5994.550408719277;6016.127661488972;6036.3661815510495;6054.243219597551;6055.273367195965;4959.851204463872;5877.73550190251;5890.558208134493;6135.447809697149;6148.231471066117;5678.3186017678145;5780.219670344618;5783.363829978614;5855.945929732689;5864.032434648406;5801.013827649225;5806.82579522615;5813.883722325614;5823.82528524145;5823.854403639943;4746.881327966828;5630.634008789416;5640.661560306395;5663.575231857545;5675.829725108253;5606.747696353756;5611.074172761449;5671.8865622688145;5797.420257974169;5846.503047241032;5693.715314234355;5724.084146536534;5750.993576124245;5754.05058165398;5754.712264386848 04:09:45 INFO - PROCESS | 1637 | |1;ext.html;493.84443900171465;495.20519566096436;499.56038685956366;511.5498361441931;542.506319249483;28549.00078497253;37904.62095379045;39711.81585012827;39828.40257396134;41622.791886040526;40402.39396409049;40570.59429405705;40639;40655.79672101643;40679.796601016955;7744.457887947846;8973.192412682874;9184.632614695403;9187.402818816756;9191.126842949909;7751.108622508399;9082.228010619105;10766.623168189075;10779.730506737316;10882.2926509777;10809.945950270278;10866.45667716615;10873.83689244662;10902.727431814188;10921.563137474532;7748.845023099563;7942.404319676048;10720.249582529226;10739.24825262232;10811.459427028656;10677.305975111592;10834.458277086193;10835.295705779099;10840.078593319577;10846.566137354497;38056.61943380586;38480.80759596212;38512.422313665316;38542.843714688606;38564.614353856385;3770.962290377116;3777.981110094432;3799.4110912808283;3825.2923209206388;3929.469521614574;28545.857270713514;28927;29625.259368515744;29663;29839.850800746073;2983.6270466191727;3026.546018097303;3083.7973190455514;3119.079871437931;3132.4361614909308;420673;423240;423470;424405;430145;51546.484535154916;52665;61460.692696537124;61852.69073654603;61995;53313.73343133337;67085;67101;67223.66388168027;67253.66373168102;14900.403983840743;15003.399864005318;15005.924970375077;15013.549593511994;15062;11346;11458.656240312805;11473.25423847464;11512.424378781196;11577.6526704199;17707.203175857117;17724.91137544304;17731.024793636218;17742.556436088944;17746.556336091442;6315.147455093595;6346.17499725042;6354.904676429857;6377;6392.360763923663;720.3984672798167;828.6064119543289;848.4697064334791;859.5788063848669;869.6173683579204;28130.01544945917;29261.853690731838;29307.560386593792;30090;30151;869.1265278395173;894.1877794336774;1001.9198464122853;1038.08129805123;1184;15032.549023529311;15056.698866022618;15145.242737863064;15219.239038048274;15364.154971476675;565830;567974;569685;570286;571705.1414742899;55075.724621376634;55327.72336138294;55343.44656553383;55390.72304638451;55430.16854747182;1295.151675652449;1345.730853829238;1346.5219846954583;1348.9055766096476;1353.363918958108;28475.857620711762;28638.284042899093;28666.570001449578;29402.55896161602;29417.11748647544;47571.76214118907;47851.80370490626;47917.5208247913;47944;48091.27863082127;471765;475709;477506;477720;478303;32484;37035.444468332455;38325.233495330496;39208.607913920496;39327.41008884812;44253.11493770171;44303.89240269019;45095.77452112718;45104;45856.541434586565;31639;36833.44749828701;36895;37007;37642.81178594199;36422;36443.63556364403;37407.81296093502;38052;38237;28743.85628071846;35752.927412177676;36285.27429451343;36767.448488273236;36788;29874.701252987194;32541.02376928696;32695.346093078482;32759.344813104082;32861.83569082139;20965.89517052405;24352.63471047971;24397.75602244026;24726.876365618056;24907.62638560459 04:09:45 INFO - PROCESS | 1637 | |2;jquery.html;346.5512161750533;383.16661261755684;385.3545311603066;390.5469655199968;412.72553751755083;18948.419633494774;20184.697229541533;20587.588248235028;20718.067686954084;20722.27472038479;20587.970601469904;20834.791652083473;21222.363329100113;21385.358439246847;21533.46166345842;5547.55619550437;5551.139573366135;5799.246098007275;5847.79532716355;5923.17075609415;5561.5828812839;5872.17789509469;5925.4370834770625;5927.733252003649;5941.88116237675;5873.882522349571;5980.372060933604;5985.371535988724;5990.071538911454;5994.490468310199;5903.645781253139;5983.790567330145;5988.640681559099;6356.650384228866;6427.903581446282;5735;5751.568632352591;5752.194692743019;5758.942410575883;5761.5678824087945;13330.533431329857;17182.828171718375;24096.638550421758;25177.118800841883;25480.23559293224;2592.2741632342972;2633.289011966758;2664.9600255996174;2669.986650066737;2673.184678673004;10098.29311948164;10233.852729938631;10451.738706532322;11703.648890533297;13602.115862469007;1781.5011796696945;1797.936255892322;1800.2259028617689;1801.4865763257408;1857.823506766855;126695;128603;130738;132839;138248.30875845658;11340.546378144947;11412.258203216765;11767.352795596324;11778.528858845722;11944.820827687592;15723.05661660304;15741.134237616812;15747.976381535163;15779.842201578067;15791.763123553155;8024.277814996678;8104.473209241381;8204.876926846102;8257.710980115668;8351.958240208882;6214.37856214384;6861.656917154122;7728.304452599181;7764.650590723431;7908.960455197687;4022.356422972369;4698.130845793539;4776.665633405698;4790.880227994328;4887.926681099786;1953.7922147972984;1990.442676050708;2009.6884982827685;2010.266252817711;2010.819026287612;972.4602845420718;979.7942432089341;997.396575072071;1011.8836333821705;1013.4223492609142;21401.78598214029;21409.78590214109;21826.626929939328;21890.343289701334;21896.12415503394;1002.644061358222;1010.4695035106481;1011.1910471622673;1024.902634249745;1048.66442738323;10872.586563746663;11246.268992515461;11264.38045907483;11264.43677816106;11309.604163854226;615618;615812;616726;642225;675988;146342.26828866;147039.2648036753;147918;153172;154696;1008.3193844155165;1012.473513772834;1027.7790275090892;1036.5231993283023;1038.4184856480395;18174.273029079217;18784.06079696037;18784.06079696037;18869.43391698251;19258.90370548138;33446.832765836014;35445.29109417849;44847.32729009002;55718.44281557295;57106;72153;72196;74532;74698.81927156894;74899.62550187214;7114.893276600958;7410.11078670563;7787.532748035136;8191.631376587949;8438.240558349778;11785.175037747618;12503.124781265224;12595.24428534291;12919.870801291867;13006.544770933351;10554;10939.617113400993;11052.889471105185;11108.722281943015;11178.888211117785;10759.623413180501;10817.296875703054;11036;11128.666140015812;11167.49746261404;10999.560017599206;11082.722931926766;11153.609623663133;11420.714482138013;11507.827382589101;7366.742164024234;7459.962700186681;7534.54792712439;7642.770716878503;7720.961395192988;10250.794984100425;10788.784224315626;11130.276532025393;11150.888491114985;11201.943990279997 04:09:45 INFO - PROCESS | 1637 | |3;mootools.html;1241.3296819717352;1407.4933024111324;1418.3475601223438;1421.417218940234;1439.5033713368887;7225.710971561138;7606.771796846097;7896.0919494258105;8160.714374996876;8168.550729709864;8072.475289106204;8145.633446494907;8160.183981601836;8175.672973081085;8226.136255693156;1915.1477592471356;2190.890455477224;2231.3975226688785;2232.944176395587;2237.697910782048;1995.4213278149318;2186.2129633332065;2249.3364457485;2254.120892851789;2272.7045484087043;2195.220696652689;2216.1689366487567;2219.855709378893;2224.899879505418;2232;2197.9340619781433;2215.213599172303;2220.877851718155;2221.3447033125267;2224.0325458425473;2172.120291282033;2187.3984654220058;2228.5765704516252;2231;2235;8154;8205.466644668077;8213.137620549816;8233.423660343778;8241.95879020607;4876.122297986361;5013.824516141917;5019.071471777733;5026.547610715017;5042.798288068473;2834.6456692913384;3157.163351711798;3290.045886692856;3357.84889679965;3358.899233023013;1126.1272513801787;1176.864660564029;1216.519474807455;1219.6584956212275;1221.0109811053076;10122.29143959923;10474.319169253975;10483.895161048367;10580.523876425503;10613.946930265376;4162.2716024696165;4176.0603864130935;4344.543822898613;4350.891227719269;4362.585554372329;8361.498310101413;8380.706675266336;8389.286910612665;8393.748187554384;8406.369522285853;4873.878153046131;4916.70499770015;4932.4327702314695;4944.90110197794;4953.777080031407;3956.4263181838473;4307.987622908614;4629.86110416688;4632.884177895579;4646.094011667692;3429.6570342965506;3466.5493485847182;3468.9653103469145;3546.716262698978;3551.733619978512;955.6225291010012;1100.9174311926638;1106.3748981825242;1109.4674556213063;1113.6714669172613;870.3863776037878;873.5094877787892;874.8775171475999;888.7378223424106;915.057490784493;5284.603654725911;5485.6434331768305;5507.228987941691;5508.228847961289;5640.802571910045;537.8494021673938;548.8463230295523;553.593109064837;570.8087790590116;572.9054705973551;3357.8247613335625;3508.6315936826268;3665.2669466106886;3668.4497325401403;3691.2248427830455;9199.172074513326;9497.287703422271;9579.664711735195;9608.039196080475;9613.230941524662;7300.853982920312;9457.574409151604;9483.336166468282;9580.377275477073;9603.327767056238;7352.485326027127;7542.622868856535;7571.924280757122;7573.35626471756;7587.241275872479;5223.373195216598;5315.574754019746;5316.760745766527;5674.092145256739;5677.148427735872;8347.457415267989;9079.818403631758;9089.727308180765;9098.499582523025;9101.180893719596;7556.4710470266555;8962.68630597926;9176.174144326775;9188.127127922837;9188.254231695957;5888.733922206575;6292.2134733158355;6515.804525864231;7035.366816986496;7058.54119482232;7068.611226382598;7640.235976402315;7702.998610180641;7761;7772.727954521564;6822.317768223138;6908.412784913338;6950.339717726808;7059.929400705927;7096.929030709627;6840;6847;6860.03959445688;6873.48448866347;6920.411765000032;5465.754041068241;6033.637981721111;6242.500599951902;6320;6321.1782468278825;4760.619150468024;4803.975980120077;4814.542618451242;4857.975710121426;4976.776045078052;4883.780229889735;4920.729359885097;4939.777710002986;4990.426100998432;4991.3511243538105 04:09:45 INFO - PROCESS | 1637 | |4;prototype.html;353.2687337211971;353.3551268934196;367.8510203367636;369.6229845557533;371.4001886952572;4673.696209746364;5248.580113590913;5270.65455872137;5307.699613594665;5319.840404787853;4389.648828093753;4881.999190166016;5162.896742065156;5215.426303106655;5255.395629502608;3515.2266501369722;3998.8403363024686;4020.8190631421658;4060.675145988314;4082.4896887889013;3242.492241107884;3592.9640703593022;4054.452648892406;4073.9388909166387;4093.692973027035;3528.7592378839363;3736.4021756518828;3929.5088113985753;4052.675785937133;4070.4301397804184;3662.846203445906;3942.7974467787312;3949.98025009876;3957.3074711925296;3976.421220901183;3023.818570885754;3074.6925307469296;3208.454562724319;3451.066593395619;3473.2879759649213;4984.651074424792;5122.257272695439;5127.512886275797;5152.92270615941;5165.845024649267;4406.537313582092;4461.04087621163;4519;4519.0961807638605;4523.36672865799;4638.721676699375;5459.8362049138195;5465.098258787295;5481.643693159932;5529.557635389159;3373.578302712161;3794.867179648699;3801.5818259991656;3837.290101331235;3843.730938834283;3908.7850168240734;5438.9937861495355;5713.6000479966415;5801.88396232073;5829.912551311733;3519.384107781128;3578.1233597768714;3818.2936156810524;3823.5220597425323;3860.841747475746;3896.473976013202;3922.843086276574;3923.136510157652;3933.6066393361007;3937.468441760383;3591.4792355108884;3810.9809450952566;4324;4518.582558331277;4571.405717256735;5061.936993231463;5117.718525481134;5405.2163135985;5577.860553486195;5595.804146854841;1182.2788099259444;1210.7033776724759;1258.4085479824469;1277.2783377391745;1277.4187744576195;783.9098503672151;801.8797180422984;845.8285274894316;862.2195166980166;875.9737207883774;4032.03231224504;4218.704690671623;4684.789184486706;4718.646101542329;4979.975100124549;4773.809047638125;5115.7442127893455;5229.058769421465;5334.8933021340135;5514.834554963358;4470.843520476833;4500.611903394164;4575.611073058761;4633.791479383436;4950.727709975914;2423.97576024241;2557.4629327841362;2583.9741602583736;2665.5735082386727;2746.717672381485;4991;5412.269343638558;5578.63738856973;5687.1753595729215;5725.627834190765;5035.446100928895;5580.386157522669;5627.229756063447;5631.63394379364;5812.722259959234;5437.31443252593;5628.662280263197;5861.88276234473;5895.322037965689;5945.908127773533;5553.694546799965;5664.122061080539;5690.71546422669;5695.401982791747;5771;4773.71357718538;5339.7597108131;5627.214528808267;5637.434967089882;5646.520045796154;4980.327655766425;5939.881202376015;5952.8809423812145;5967.791127310524;6029.457348838626;3443.4876426044793;3841.3277676407074;3862.7059934922117;3876.030992251937;3886.6502014818802;4866.756662166948;5046.77289521965;5383.5423988961375;5690.886182276414;5758.366579676316;5296.788128474818;5463.743339031966;5536.861578460571;5540.307461567304;5589.506558400999;5219.530242278213;5297.973510132425;5487.231787549826;5517.420670829666;5561.6663000220115;4843.128236917389;4906.650671065486;5116.71858047796;5229.320188375639;5429.53848922846;5545.500904918576;5563.165525171256;5574.860628484158;5578.2748242728185;5578.86052848682;4937.580305674058;5009.5992320615;5052.242163675478;5298;5479 04:09:45 INFO - PROCESS | 1637 | |5;yui.html;672.8519725660353;696.3558708194921;743.3904198557182;775.9146493885672;788.2905385153363;14312.427502899884;14988.250587470637;15012.174330411823;15021.248937553133;15034.323455444517;13633.522826701068;13734.58796236112;13738.725225495484;13760.862391376084;13813.102148360349;856.9485830850138;871.6774793326479;888.4802390601474;892.0811564088999;897.896741874683;879.7668617816283;893.0578239956843;893.1024320557831;894.8299823033635;894.9865752013725;832.8251067275849;897.9371443998923;907.3603109807602;939.065629698451;942.4580866002042;888.7467071884482;924.3945215883607;933.1135421349677;935.1163150822475;941.3410612571193;697.2643860726931;699.1016543741318;699.8390370214828;699.9055127557816;702.4310308650009;14827.851721482755;14867.776983345258;14889.181095039768;15022.24888755558;15054.172020538866;13717.0398072135;13990.930045349709;14019.509317173952;14062.507812226626;14084;11433.42832858362;11474.655760327203;11554.248973816675;11831.526738930519;12059.97490213333;3570.553680789901;3591.2637909228547;3622.5652921649307;3733.757305775116;3758.8120593970193;99058;100233.4988325061;100476.9952300475;100757;101203;10396.896031039743;10487.108595769292;10533.525991330409;10704.19718521114;10728.195385345975;21798.56402871934;22194.667079993815;22240.999155037738;22258.554828903332;22330.330090097323;7432.554046757212;7502.099748030271;7516.060492438445;7582.962085189539;7698.384129269645;4099.364598487239;4192.329227323614;4200.327947528381;4270.957290427056;4310.353446982915;3536.7524273300623;3635.709143268532;3637.399829028234;3644.580873199563;3649.799261040668;640.6348381422545;642.3095172689377;654.8231977366084;670.7216505150308;672.0758956434902;630.7256343490596;651.4788169464409;667.5860966200986;670.0853335197518;681.2097966358999;8681.609327580274;9482.525873706287;9654.71035868925;9932.900670993198;10072.345297555636;636.8280564247627;648.7307767276621;656.6093174561129;661.6427129350097;662.2880403566186;4728.929066064012;4809.831655892027;4881.389826271716;4894.8042078317185;4936.308916751657;101169.49415252877;101691.4915425433;101903;102021;103813;47386;75428.24571754212;76093.6195319031;85698;89539;68070.31929680739;68159;69465;74203;76628;10301.124404425707;10307.484625768531;10507.632232871812;10510.947445262726;10542.367457952547;36160.63839361573;46300.1079093563;46543.943346259795;48232.517674822804;49749;68441.65779171072;68579;69207.65396172987;69562.30437695558;70588;12399.00807935381;12814.743705126031;12825.551105711254;12866.421011054337;12911.22532648044;12394.690132746753;13958.930205348908;14307.570772876414;14371.640708982359;15022.62443438879;12982.675433114247;13170.934145329595;13230.933845330712;13303;13687;11616.128790340927;12845.807312890502;12972.545960891324;13108.475660973836;13833.377498012815;12790.744185116431;12839.807402888777;12931.676708081997;12964.740705186032;12969.546065888026;8844.73465796027;10956.671299861016;10959.50682219318;10966.725831854268;11111.72220694489;8537.274331681876;8624.741257762276;10362.585496580052;10628.8937110631;10660.360378377321 04:09:45 INFO - PROCESS | 1637 | __end_tp_report 04:09:45 INFO - PROCESS | 1637 | __start_cc_report 04:09:45 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,1937 04:09:45 INFO - PROCESS | 1637 | __end_cc_report 04:09:45 INFO - PROCESS | 1637 | __startTimestamp1486642185729__endTimestamp 04:09:45 INFO - PROCESS | 1637 | 04:09:45 INFO - PROCESS | 1637 | ------- Summary: start ------- 04:09:45 INFO - PROCESS | 1637 | Number of tests: 6 04:09:45 INFO - PROCESS | 1637 | 04:09:45 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5498.84 Median:5640.66 stddev:614.86 (10.9%) stddev-sans-first:591.08 04:09:45 INFO - PROCESS | 1637 | Values: 3257.9 3266.9 3275.9 3296.0 3339.8 5271.2 5360.7 5447.6 5517.1 5537.2 4698.7 5259.2 5436.5 5480.1 5484.5 4623.0 4946.1 4977.8 4996.8 5129.2 5116.2 5131.3 5133.4 5145.0 5150.4 4880.2 4888.2 4906.0 5070.1 5127.9 4972.1 4998.3 5040.2 5053.3 5097.8 4947.6 4961.0 4999.0 5001.0 5061.1 5309.1 5445.0 5449.3 5466.5 5481.4 5771.3 5836.3 5852.4 5898.4 5900.1 6026.6 6074.8 6076.2 6077.1 6121.5 5575.3 5576.6 5582.3 5588.2 5594.9 5927.5 6135.1 6143.7 6143.7 6147.9 5754.5 5782.1 5872.7 5882.6 5976.5 6095.8 6099.9 6105.8 6110.1 6112.7 5915.1 6005.0 6009.2 6044.9 6045.7 5741.7 5800.5 5801.9 5969.2 6018.7 4869.6 4878.2 4881.6 4885.7 4918.7 3702.9 4351.6 4352.7 4362.6 4385.7 5301.6 5367.1 5367.4 5481.3 5524.8 5988.8 6034.2 6037.6 6090.1 6134.6 5426.0 5473.5 5490.5 5495.9 5497.9 5131.0 5270.3 5273.6 5278.9 5307.6 5076.9 5372.7 5906.8 6123.5 6147.2 5794.8 6011.2 6023.9 6047.6 6064.1 6062.9 6119.0 6160.8 6203.5 6234.4 5994.6 6016.1 6036.4 6054.2 6055.3 4959.9 5877.7 5890.6 6135.4 6148.2 5678.3 5780.2 5783.4 5855.9 5864.0 5801.0 5806.8 5813.9 5823.8 5823.9 4746.9 5630.6 5640.7 5663.6 5675.8 5606.7 5611.1 5671.9 5797.4 5846.5 5693.7 5724.1 5751.0 5754.1 5754.7 04:09:45 INFO - PROCESS | 1637 | 04:09:45 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:63111.29 Median:3774.47 stddev:131366.54 (3480.4%) stddev-sans-first:131650.93 04:09:45 INFO - PROCESS | 1637 | Values: 493.8 495.2 499.6 511.5 542.5 28549.0 37904.6 39711.8 39828.4 41622.8 40402.4 40570.6 40639.0 40655.8 40679.8 7744.5 8973.2 9184.6 9187.4 9191.1 7751.1 9082.2 10766.6 10779.7 10882.3 10809.9 10866.5 10873.8 10902.7 10921.6 7748.8 7942.4 10720.2 10739.2 10811.5 10677.3 10834.5 10835.3 10840.1 10846.6 38056.6 38480.8 38512.4 38542.8 38564.6 3771.0 3778.0 3799.4 3825.3 3929.5 28545.9 28927.0 29625.3 29663.0 29839.9 2983.6 3026.5 3083.8 3119.1 3132.4 420673.0 423240.0 423470.0 424405.0 430145.0 51546.5 52665.0 61460.7 61852.7 61995.0 53313.7 67085.0 67101.0 67223.7 67253.7 14900.4 15003.4 15005.9 15013.5 15062.0 11346.0 11458.7 11473.3 11512.4 11577.7 17707.2 17724.9 17731.0 17742.6 17746.6 6315.1 6346.2 6354.9 6377.0 6392.4 720.4 828.6 848.5 859.6 869.6 28130.0 29261.9 29307.6 30090.0 30151.0 869.1 894.2 1001.9 1038.1 1184.0 15032.5 15056.7 15145.2 15219.2 15364.2 565830.0 567974.0 569685.0 570286.0 571705.1 55075.7 55327.7 55343.4 55390.7 55430.2 1295.2 1345.7 1346.5 1348.9 1353.4 28475.9 28638.3 28666.6 29402.6 29417.1 47571.8 47851.8 47917.5 47944.0 48091.3 471765.0 475709.0 477506.0 477720.0 478303.0 32484.0 37035.4 38325.2 39208.6 39327.4 44253.1 44303.9 45095.8 45104.0 45856.5 31639.0 36833.4 36895.0 37007.0 37642.8 36422.0 36443.6 37407.8 38052.0 38237.0 28743.9 35752.9 36285.3 36767.4 36788.0 29874.7 32541.0 32695.3 32759.3 32861.8 20965.9 24352.6 24397.8 24726.9 24907.6 04:09:45 INFO - PROCESS | 1637 | 04:09:45 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:36600.41 Median:21028.58 stddev:106306.79 (505.5%) stddev-sans-first:106570.16 04:09:45 INFO - PROCESS | 1637 | Values: 346.6 383.2 385.4 390.5 412.7 18948.4 20184.7 20587.6 20718.1 20722.3 20588.0 20834.8 21222.4 21385.4 21533.5 5547.6 5551.1 5799.2 5847.8 5923.2 5561.6 5872.2 5925.4 5927.7 5941.9 5873.9 5980.4 5985.4 5990.1 5994.5 5903.6 5983.8 5988.6 6356.7 6427.9 5735.0 5751.6 5752.2 5758.9 5761.6 13330.5 17182.8 24096.6 25177.1 25480.2 2592.3 2633.3 2665.0 2670.0 2673.2 10098.3 10233.9 10451.7 11703.6 13602.1 1781.5 1797.9 1800.2 1801.5 1857.8 126695.0 128603.0 130738.0 132839.0 138248.3 11340.5 11412.3 11767.4 11778.5 11944.8 15723.1 15741.1 15748.0 15779.8 15791.8 8024.3 8104.5 8204.9 8257.7 8352.0 6214.4 6861.7 7728.3 7764.7 7909.0 4022.4 4698.1 4776.7 4790.9 4887.9 1953.8 1990.4 2009.7 2010.3 2010.8 972.5 979.8 997.4 1011.9 1013.4 21401.8 21409.8 21826.6 21890.3 21896.1 1002.6 1010.5 1011.2 1024.9 1048.7 10872.6 11246.3 11264.4 11264.4 11309.6 615618.0 615812.0 616726.0 642225.0 675988.0 146342.3 147039.3 147918.0 153172.0 154696.0 1008.3 1012.5 1027.8 1036.5 1038.4 18174.3 18784.1 18784.1 18869.4 19258.9 33446.8 35445.3 44847.3 55718.4 57106.0 72153.0 72196.0 74532.0 74698.8 74899.6 7114.9 7410.1 7787.5 8191.6 8438.2 11785.2 12503.1 12595.2 12919.9 13006.5 10554.0 10939.6 11052.9 11108.7 11178.9 10759.6 10817.3 11036.0 11128.7 11167.5 10999.6 11082.7 11153.6 11420.7 11507.8 7366.7 7460.0 7534.5 7642.8 7721.0 10250.8 10788.8 11130.3 11150.9 11201.9 04:09:45 INFO - PROCESS | 1637 | 04:09:45 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:5184.97 Median:5300.09 stddev:2841.32 (53.6%) stddev-sans-first:2833.83 04:09:45 INFO - PROCESS | 1637 | Values: 1241.3 1407.5 1418.3 1421.4 1439.5 7225.7 7606.8 7896.1 8160.7 8168.6 8072.5 8145.6 8160.2 8175.7 8226.1 1915.1 2190.9 2231.4 2232.9 2237.7 1995.4 2186.2 2249.3 2254.1 2272.7 2195.2 2216.2 2219.9 2224.9 2232.0 2197.9 2215.2 2220.9 2221.3 2224.0 2172.1 2187.4 2228.6 2231.0 2235.0 8154.0 8205.5 8213.1 8233.4 8242.0 4876.1 5013.8 5019.1 5026.5 5042.8 2834.6 3157.2 3290.0 3357.8 3358.9 1126.1 1176.9 1216.5 1219.7 1221.0 10122.3 10474.3 10483.9 10580.5 10613.9 4162.3 4176.1 4344.5 4350.9 4362.6 8361.5 8380.7 8389.3 8393.7 8406.4 4873.9 4916.7 4932.4 4944.9 4953.8 3956.4 4308.0 4629.9 4632.9 4646.1 3429.7 3466.5 3469.0 3546.7 3551.7 955.6 1100.9 1106.4 1109.5 1113.7 870.4 873.5 874.9 888.7 915.1 5284.6 5485.6 5507.2 5508.2 5640.8 537.8 548.8 553.6 570.8 572.9 3357.8 3508.6 3665.3 3668.4 3691.2 9199.2 9497.3 9579.7 9608.0 9613.2 7300.9 9457.6 9483.3 9580.4 9603.3 7352.5 7542.6 7571.9 7573.4 7587.2 5223.4 5315.6 5316.8 5674.1 5677.1 8347.5 9079.8 9089.7 9098.5 9101.2 7556.5 8962.7 9176.2 9188.1 9188.3 5888.7 6292.2 6515.8 7035.4 7058.5 7068.6 7640.2 7703.0 7761.0 7772.7 6822.3 6908.4 6950.3 7059.9 7096.9 6840.0 6847.0 6860.0 6873.5 6920.4 5465.8 6033.6 6242.5 6320.0 6321.2 4760.6 4804.0 4814.5 4858.0 4976.8 4883.8 4920.7 4939.8 4990.4 4991.4 04:09:45 INFO - PROCESS | 1637 | 04:09:45 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4414.02 Median:4980.15 stddev:1374.51 (27.6%) stddev-sans-first:1344.15 04:09:45 INFO - PROCESS | 1637 | Values: 353.3 353.4 367.9 369.6 371.4 4673.7 5248.6 5270.7 5307.7 5319.8 4389.6 4882.0 5162.9 5215.4 5255.4 3515.2 3998.8 4020.8 4060.7 4082.5 3242.5 3593.0 4054.5 4073.9 4093.7 3528.8 3736.4 3929.5 4052.7 4070.4 3662.8 3942.8 3950.0 3957.3 3976.4 3023.8 3074.7 3208.5 3451.1 3473.3 4984.7 5122.3 5127.5 5152.9 5165.8 4406.5 4461.0 4519.0 4519.1 4523.4 4638.7 5459.8 5465.1 5481.6 5529.6 3373.6 3794.9 3801.6 3837.3 3843.7 3908.8 5439.0 5713.6 5801.9 5829.9 3519.4 3578.1 3818.3 3823.5 3860.8 3896.5 3922.8 3923.1 3933.6 3937.5 3591.5 3811.0 4324.0 4518.6 4571.4 5061.9 5117.7 5405.2 5577.9 5595.8 1182.3 1210.7 1258.4 1277.3 1277.4 783.9 801.9 845.8 862.2 876.0 4032.0 4218.7 4684.8 4718.6 4980.0 4773.8 5115.7 5229.1 5334.9 5514.8 4470.8 4500.6 4575.6 4633.8 4950.7 2424.0 2557.5 2584.0 2665.6 2746.7 4991.0 5412.3 5578.6 5687.2 5725.6 5035.4 5580.4 5627.2 5631.6 5812.7 5437.3 5628.7 5861.9 5895.3 5945.9 5553.7 5664.1 5690.7 5695.4 5771.0 4773.7 5339.8 5627.2 5637.4 5646.5 4980.3 5939.9 5952.9 5967.8 6029.5 3443.5 3841.3 3862.7 3876.0 3886.7 4866.8 5046.8 5383.5 5690.9 5758.4 5296.8 5463.7 5536.9 5540.3 5589.5 5219.5 5298.0 5487.2 5517.4 5561.7 4843.1 4906.7 5116.7 5229.3 5429.5 5545.5 5563.2 5574.9 5578.3 5578.9 4937.6 5009.6 5052.2 5298.0 5479.0 04:09:45 INFO - PROCESS | 1637 | 04:09:45 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:19506.70 Median:3691.78 stddev:27752.93 (751.7%) stddev-sans-first:27794.76 04:09:45 INFO - PROCESS | 1637 | Values: 672.9 696.4 743.4 775.9 788.3 14312.4 14988.3 15012.2 15021.2 15034.3 13633.5 13734.6 13738.7 13760.9 13813.1 856.9 871.7 888.5 892.1 897.9 879.8 893.1 893.1 894.8 895.0 832.8 897.9 907.4 939.1 942.5 888.7 924.4 933.1 935.1 941.3 697.3 699.1 699.8 699.9 702.4 14827.9 14867.8 14889.2 15022.2 15054.2 13717.0 13990.9 14019.5 14062.5 14084.0 11433.4 11474.7 11554.2 11831.5 12060.0 3570.6 3591.3 3622.6 3733.8 3758.8 99058.0 100233.5 100477.0 100757.0 101203.0 10396.9 10487.1 10533.5 10704.2 10728.2 21798.6 22194.7 22241.0 22258.6 22330.3 7432.6 7502.1 7516.1 7583.0 7698.4 4099.4 4192.3 4200.3 4271.0 4310.4 3536.8 3635.7 3637.4 3644.6 3649.8 640.6 642.3 654.8 670.7 672.1 630.7 651.5 667.6 670.1 681.2 8681.6 9482.5 9654.7 9932.9 10072.3 636.8 648.7 656.6 661.6 662.3 4728.9 4809.8 4881.4 4894.8 4936.3 101169.5 101691.5 101903.0 102021.0 103813.0 47386.0 75428.2 76093.6 85698.0 89539.0 68070.3 68159.0 69465.0 74203.0 76628.0 10301.1 10307.5 10507.6 10510.9 10542.4 36160.6 46300.1 46543.9 48232.5 49749.0 68441.7 68579.0 69207.7 69562.3 70588.0 12399.0 12814.7 12825.6 12866.4 12911.2 12394.7 13958.9 14307.6 14371.6 15022.6 12982.7 13170.9 13230.9 13303.0 13687.0 11616.1 12845.8 12972.5 13108.5 13833.4 12790.7 12839.8 12931.7 12964.7 12969.5 8844.7 10956.7 10959.5 10966.7 11111.7 8537.3 8624.7 10362.6 10628.9 10660.4 04:09:45 INFO - PROCESS | 1637 | -------- Summary: end -------- 04:09:45 INFO - PROCESS | 1637 | 04:09:46 INFO - TEST-INFO | 1637: exit 0 04:09:46 INFO - TEST-OK | dromaeo_css | took 1118404ms 04:09:46 INFO - TEST-START | kraken 04:09:46 INFO - operating with platform_type : mac_ 04:09:46 INFO - Initialising browser for kraken test... 04:09:46 INFO - TEST-INFO | started process 1651 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/tmpNVf5GT/profile http://localhost:49238/getInfo.html) 04:09:48 INFO - PROCESS | 1651 | JavaScript error: chrome://webcompat/content/lib/ua_overrider.jsm, line 109: NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS: Component returned failure code: 0x804b0050 (NS_ERROR_INSUFFICIENT_DOMAIN_LEVELS) [nsIEffectiveTLDService.getBaseDomain] 04:09:48 INFO - PROCESS | 1651 | __metrics Screen width/height:1600/1200 04:09:48 INFO - PROCESS | 1651 | colorDepth:24 04:09:48 INFO - PROCESS | 1651 | Browser inner width/height: 1024/689 04:09:48 INFO - PROCESS | 1651 | __metrics 04:09:48 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:09:48 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:09:49 INFO - TEST-INFO | 1651: exit 0 04:09:49 INFO - Browser initialized. 04:09:49 INFO - Running cycle 1/1 for kraken test... 04:09:49 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/T/tmpNVf5GT/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:10:01 INFO - PROCESS | 1652 | RSS: Main: 236654592 04:10:01 INFO - PROCESS | 1652 | 04:10:04 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection) 04:10:05 INFO - PROCESS | 1652 | RSS: Main: 288628736 04:10:05 INFO - PROCESS | 1652 | 04:10:08 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-dft) 04:10:08 INFO - PROCESS | 1652 | RSS: Main: 290697216 04:10:08 INFO - PROCESS | 1652 | 04:10:11 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-fft) 04:10:12 INFO - PROCESS | 1652 | RSS: Main: 382353408 04:10:12 INFO - PROCESS | 1652 | 04:10:14 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator) 04:10:15 INFO - PROCESS | 1652 | RSS: Main: 283521024 04:10:15 INFO - PROCESS | 1652 | 04:10:17 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:10:17 INFO - PROCESS | 1652 | RSS: Main: 287932416 04:10:17 INFO - PROCESS | 1652 | 04:10:20 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom) 04:10:21 INFO - PROCESS | 1652 | RSS: Main: 329580544 04:10:21 INFO - PROCESS | 1652 | 04:10:24 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate) 04:10:25 INFO - PROCESS | 1652 | RSS: Main: 332996608 04:10:25 INFO - PROCESS | 1652 | 04:10:27 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial) 04:10:28 INFO - PROCESS | 1652 | RSS: Main: 330690560 04:10:28 INFO - PROCESS | 1652 | 04:10:30 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:10:30 INFO - PROCESS | 1652 | RSS: Main: 306573312 04:10:30 INFO - PROCESS | 1652 | 04:10:32 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:10:33 INFO - PROCESS | 1652 | RSS: Main: 309530624 04:10:33 INFO - PROCESS | 1652 | 04:10:35 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:10:36 INFO - PROCESS | 1652 | RSS: Main: 310394880 04:10:36 INFO - PROCESS | 1652 | 04:10:38 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:10:39 INFO - PROCESS | 1652 | RSS: Main: 328335360 04:10:39 INFO - PROCESS | 1652 | 04:10:42 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:10:43 INFO - PROCESS | 1652 | RSS: Main: 322813952 04:10:43 INFO - PROCESS | 1652 | 04:10:45 INFO - PROCESS | 1652 | Cycle 1(1): loaded http://localhost:49238/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49238/tests/kraken/driver.html?testName=ai-astar) 04:10:45 INFO - PROCESS | 1652 | RSS: Main: 368058368 04:10:45 INFO - PROCESS | 1652 | 04:10:45 INFO - PROCESS | 1652 | __start_tp_report 04:10:45 INFO - PROCESS | 1652 | _x_x_mozilla_page_load 04:10:45 INFO - PROCESS | 1652 | _x_x_mozilla_page_load_details 04:10:45 INFO - PROCESS | 1652 | |i|pagename|runs| 04:10:45 INFO - PROCESS | 1652 | |0;ai-astar;116;115;113;115;114;115;115;114;114;114 04:10:45 INFO - PROCESS | 1652 | |1;audio-beat-detection;168;140;141;146;113;110;113;107;136;137 04:10:45 INFO - PROCESS | 1652 | |2;audio-dft;186;186;184;180;185;184;181;181;182;187 04:10:45 INFO - PROCESS | 1652 | |3;audio-fft;81;60;61;102;87;85;71;60;76;58 04:10:45 INFO - PROCESS | 1652 | |4;audio-oscillator;87;72;84;67;70;70;84;69;68;83 04:10:45 INFO - PROCESS | 1652 | |5;imaging-gaussian-blur;89;89;88;87;88;88;88;87;88;87 04:10:45 INFO - PROCESS | 1652 | |6;imaging-darkroom;94;95;97;95;96;96;95;110;150;95 04:10:45 INFO - PROCESS | 1652 | |7;imaging-desaturate;86;84;85;87;86;85;86;85;87;85 04:10:45 INFO - PROCESS | 1652 | |8;json-parse-financial;61;58;59;59;60;60;60;60;59;59 04:10:45 INFO - PROCESS | 1652 | |9;json-stringify-tinderbox;64;74;77;74;72;68;69;69;69;70 04:10:45 INFO - PROCESS | 1652 | |10;stanford-crypto-aes;89;90;89;89;88;89;90;88;94;88 04:10:45 INFO - PROCESS | 1652 | |11;stanford-crypto-ccm;147;158;141;142;139;147;146;140;175;159 04:10:45 INFO - PROCESS | 1652 | |12;stanford-crypto-pbkdf2;174;173;172;172;172;175;168;172;217;186 04:10:45 INFO - PROCESS | 1652 | |13;stanford-crypto-sha256-iterative;67;68;68;67;65;66;64;66;66;64 04:10:45 INFO - PROCESS | 1652 | __end_tp_report 04:10:45 INFO - PROCESS | 1652 | __start_cc_report 04:10:45 INFO - PROCESS | 1652 | _x_x_mozilla_cycle_collect,2050 04:10:45 INFO - PROCESS | 1652 | __end_cc_report 04:10:45 INFO - PROCESS | 1652 | __startTimestamp1486642245352__endTimestamp 04:10:45 INFO - PROCESS | 1652 | 04:10:45 INFO - PROCESS | 1652 | ------- Summary: start ------- 04:10:45 INFO - PROCESS | 1652 | Number of tests: 14 04:10:45 INFO - PROCESS | 1652 | 04:10:45 INFO - PROCESS | 1652 | [#0] ai-astar Cycles:10 Average:114.50 Median:115.00 stddev:0.85 (0.7%) stddev-sans-first:0.71 04:10:45 INFO - PROCESS | 1652 | Values: 116.0 115.0 113.0 115.0 114.0 115.0 115.0 114.0 114.0 114.0 04:10:45 INFO - PROCESS | 1652 | 04:10:45 INFO - PROCESS | 1652 | [#1] audio-beat-detection Cycles:10 Average:131.10 Median:138.50 stddev:19.72 (14.2%) stddev-sans-first:15.76 04:10:45 INFO - PROCESS | 1652 | Values: 168.0 140.0 141.0 146.0 113.0 110.0 113.0 107.0 136.0 137.0 04:10:45 INFO - PROCESS | 1652 | 04:10:45 INFO - PROCESS | 1652 | [#2] audio-dft Cycles:10 Average:183.60 Median:184.50 stddev:2.46 (1.3%) stddev-sans-first:2.45 04:10:45 INFO - PROCESS | 1652 | Values: 186.0 186.0 184.0 180.0 185.0 184.0 181.0 181.0 182.0 187.0 04:10:45 INFO - PROCESS | 1652 | 04:10:45 INFO - PROCESS | 1652 | [#3] audio-fft Cycles:10 Average:74.10 Median:73.50 stddev:14.73 (20.0%) stddev-sans-first:15.41 04:10:45 INFO - PROCESS | 1652 | Values: 81.0 60.0 61.0 102.0 87.0 85.0 71.0 60.0 76.0 58.0 04:10:45 INFO - PROCESS | 1652 | 04:10:45 INFO - PROCESS | 1652 | [#4] audio-oscillator Cycles:10 Average:75.40 Median:77.50 stddev:8.00 (10.3%) stddev-sans-first:7.30 04:10:45 INFO - PROCESS | 1652 | Values: 87.0 72.0 84.0 67.0 70.0 70.0 84.0 69.0 68.0 83.0 04:10:45 INFO - PROCESS | 1652 | 04:10:45 INFO - PROCESS | 1652 | [#5] imaging-gaussian-blur Cycles:10 Average:87.90 Median:88.00 stddev:0.74 (0.8%) stddev-sans-first:0.67 04:10:45 INFO - PROCESS | 1652 | Values: 89.0 89.0 88.0 87.0 88.0 88.0 88.0 87.0 88.0 87.0 04:10:45 INFO - PROCESS | 1652 | 04:10:45 INFO - PROCESS | 1652 | [#6] imaging-darkroom Cycles:10 Average:102.30 Median:95.00 stddev:17.40 (18.3%) stddev-sans-first:18.19 04:10:45 INFO - PROCESS | 1652 | Values: 94.0 95.0 97.0 95.0 96.0 96.0 95.0 110.0 150.0 95.0 04:10:45 INFO - PROCESS | 1652 | 04:10:45 INFO - PROCESS | 1652 | [#7] imaging-desaturate Cycles:10 Average:85.60 Median:86.00 stddev:0.97 (1.1%) stddev-sans-first:1.01 04:10:45 INFO - PROCESS | 1652 | Values: 86.0 84.0 85.0 87.0 86.0 85.0 86.0 85.0 87.0 85.0 04:10:45 INFO - PROCESS | 1652 | 04:10:45 INFO - PROCESS | 1652 | [#8] json-parse-financial Cycles:10 Average:59.50 Median:60.00 stddev:0.85 (1.4%) stddev-sans-first:0.71 04:10:45 INFO - PROCESS | 1652 | Values: 61.0 58.0 59.0 59.0 60.0 60.0 60.0 60.0 59.0 59.0 04:10:45 INFO - PROCESS | 1652 | 04:10:45 INFO - PROCESS | 1652 | [#9] json-stringify-tinderbox Cycles:10 Average:70.60 Median:71.00 stddev:3.72 (5.2%) stddev-sans-first:3.08 04:10:45 INFO - PROCESS | 1652 | Values: 64.0 74.0 77.0 74.0 72.0 68.0 69.0 69.0 69.0 70.0 04:10:45 INFO - PROCESS | 1652 | 04:10:45 INFO - PROCESS | 1652 | [#10] stanford-crypto-aes Cycles:10 Average:89.40 Median:89.00 stddev:1.78 (2.0%) stddev-sans-first:1.88 04:10:45 INFO - PROCESS | 1652 | Values: 89.0 90.0 89.0 89.0 88.0 89.0 90.0 88.0 94.0 88.0 04:10:45 INFO - PROCESS | 1652 | 04:10:45 INFO - PROCESS | 1652 | [#11] stanford-crypto-ccm Cycles:10 Average:149.40 Median:147.00 stddev:11.38 (7.7%) stddev-sans-first:12.04 04:10:45 INFO - PROCESS | 1652 | Values: 147.0 158.0 141.0 142.0 139.0 147.0 146.0 140.0 175.0 159.0 04:10:45 INFO - PROCESS | 1652 | 04:10:45 INFO - PROCESS | 1652 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:178.10 Median:173.50 stddev:14.45 (8.3%) stddev-sans-first:15.25 04:10:45 INFO - PROCESS | 1652 | Values: 174.0 173.0 172.0 172.0 172.0 175.0 168.0 172.0 217.0 186.0 04:10:45 INFO - PROCESS | 1652 | 04:10:45 INFO - PROCESS | 1652 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:66.10 Median:66.50 stddev:1.45 (2.2%) stddev-sans-first:1.50 04:10:45 INFO - PROCESS | 1652 | Values: 67.0 68.0 68.0 67.0 65.0 66.0 64.0 66.0 66.0 64.0 04:10:45 INFO - PROCESS | 1652 | -------- Summary: end -------- 04:10:45 INFO - PROCESS | 1652 | 04:10:46 INFO - TEST-INFO | 1652: exit 0 04:10:46 INFO - TEST-OK | kraken | took 59904ms 04:10:46 INFO - SUITE-END | took 1178s 04:10:46 INFO - Completed test suite (00:19:38) 04:10:46 INFO - javascript benchmark 04:10:46 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7066.808154583701, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3257.9185520361993, 3266.9346613067737, 3275.9181020474493, 3295.983520082399, 3339.8163101029436, 5271.15661494161, 5360.678359298445, 5447.645903016301, 5517.144842549406, 5537.169424586309, 4698.694584851991, 5259.237410575464, 5436.537894278991, 5480.095784195603, 5484.478974497426, 4622.9768851155695, 4946.084974279752, 4977.776000080005, 4996.77514511846, 5129.179331306992, 5116.1814109742445, 5131.332926719521, 5133.435322114565, 5145.0, 5150.433452320261, 4880.170371036932, 4888.169011268093, 4905.994271174436, 5070.112730272206, 5127.897442051175, 4972.129877271463, 4998.300237966688, 5040.243963405482, 5053.343065401511, 5097.847064588032, 4947.604191664658, 4960.975195124038, 4999.025190087934, 5001.024800163969, 5061.114304996648, 5309.070912590281, 5445.0, 5449.291592093042, 5466.508014278734, 5481.369642491085, 5771.278590176228, 5836.328822185418, 5852.4440178183, 5898.4101589840675, 5900.114982752579, 6026.638401695912, 6074.848128796772, 6076.240469941257, 6077.088436734481, 6121.510279177655, 5575.275214222166, 5576.553875689976, 5582.274304340491, 5588.21764952907, 5594.860128496779, 5927.496162826122, 6135.110408990671, 6143.692815359214, 6143.692815359214, 6147.907781383283, 5754.539636829044, 5782.132680098019, 5872.706364681749, 5882.588218824641, 5976.462118409364, 6095.8476038098515, 6099.9085013724825, 6105.8473538161015, 6110.083487476914, 6112.694365281718, 5915.142304365843, 6004.969975150097, 6009.248843894513, 6044.909326360108, 6045.667488288098, 5741.712914354265, 5800.477956983892, 5801.88396232073, 5969.2240008799445, 6018.7291571878495, 4869.63477739171, 4878.219484882473, 4881.609471242292, 4885.706857588485, 4918.680285781413, 3702.851885924587, 4351.608355248043, 4352.651787856964, 4362.607365337135, 4385.6710746694125, 5301.575873930076, 5367.060764366221, 5367.3827509836865, 5481.260029895992, 5524.779008839681, 5988.820335389945, 6034.24571928509, 6037.607555508878, 6090.086487026892, 6134.601250918676, 5425.996190704732, 5473.507384335429, 5490.450954904558, 5495.945040549624, 5497.862553436196, 5131.0, 5270.288511051036, 5273.604479664041, 5278.868028299324, 5307.601929855199, 5076.873078172927, 5372.683692495286, 5906.822795316061, 6123.526657168292, 6147.170132032118, 5794.768209271582, 6011.188489553854, 6023.909641355471, 6047.637141771508, 6064.06007068905, 6062.938985677577, 6119.015143218386, 6160.845978850564, 6203.534734894811, 6234.37656234391, 5994.550408719277, 6016.127661488972, 6036.3661815510495, 6054.243219597551, 6055.273367195965, 4959.851204463872, 5877.73550190251, 5890.558208134493, 6135.447809697149, 6148.231471066117, 5678.3186017678145, 5780.219670344618, 5783.363829978614, 5855.945929732689, 5864.032434648406, 5801.013827649225, 5806.82579522615, 5813.883722325614, 5823.82528524145, 5823.854403639943, 4746.881327966828, 5630.634008789416, 5640.661560306395, 5663.575231857545, 5675.829725108253, 5606.747696353756, 5611.074172761449, 5671.8865622688145, 5797.420257974169, 5846.503047241032, 5693.715314234355, 5724.084146536534, 5750.993576124245, 5754.05058165398, 5754.712264386848], "value": 5461.170503000315, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [493.84443900171465, 495.20519566096436, 499.56038685956366, 511.5498361441931, 542.506319249483, 28549.00078497253, 37904.62095379045, 39711.81585012827, 39828.40257396134, 41622.791886040526, 40402.39396409049, 40570.59429405705, 40639.0, 40655.79672101643, 40679.796601016955, 7744.457887947846, 8973.192412682874, 9184.632614695403, 9187.402818816756, 9191.126842949909, 7751.108622508399, 9082.228010619105, 10766.623168189075, 10779.730506737316, 10882.2926509777, 10809.945950270278, 10866.45667716615, 10873.83689244662, 10902.727431814188, 10921.563137474532, 7748.845023099563, 7942.404319676048, 10720.249582529226, 10739.24825262232, 10811.459427028656, 10677.305975111592, 10834.458277086193, 10835.295705779099, 10840.078593319577, 10846.566137354497, 38056.61943380586, 38480.80759596212, 38512.422313665316, 38542.843714688606, 38564.614353856385, 3770.962290377116, 3777.981110094432, 3799.4110912808283, 3825.2923209206388, 3929.469521614574, 28545.857270713514, 28927.0, 29625.259368515744, 29663.0, 29839.850800746073, 2983.6270466191727, 3026.546018097303, 3083.7973190455514, 3119.079871437931, 3132.4361614909308, 420673.0, 423240.0, 423470.0, 424405.0, 430145.0, 51546.484535154916, 52665.0, 61460.692696537124, 61852.69073654603, 61995.0, 53313.73343133337, 67085.0, 67101.0, 67223.66388168027, 67253.66373168102, 14900.403983840743, 15003.399864005318, 15005.924970375077, 15013.549593511994, 15062.0, 11346.0, 11458.656240312805, 11473.25423847464, 11512.424378781196, 11577.6526704199, 17707.203175857117, 17724.91137544304, 17731.024793636218, 17742.556436088944, 17746.556336091442, 6315.147455093595, 6346.17499725042, 6354.904676429857, 6377.0, 6392.360763923663, 720.3984672798167, 828.6064119543289, 848.4697064334791, 859.5788063848669, 869.6173683579204, 28130.01544945917, 29261.853690731838, 29307.560386593792, 30090.0, 30151.0, 869.1265278395173, 894.1877794336774, 1001.9198464122853, 1038.08129805123, 1184.0, 15032.549023529311, 15056.698866022618, 15145.242737863064, 15219.239038048274, 15364.154971476675, 565830.0, 567974.0, 569685.0, 570286.0, 571705.1414742899, 55075.724621376634, 55327.72336138294, 55343.44656553383, 55390.72304638451, 55430.16854747182, 1295.151675652449, 1345.730853829238, 1346.5219846954583, 1348.9055766096476, 1353.363918958108, 28475.857620711762, 28638.284042899093, 28666.570001449578, 29402.55896161602, 29417.11748647544, 47571.76214118907, 47851.80370490626, 47917.5208247913, 47944.0, 48091.27863082127, 471765.0, 475709.0, 477506.0, 477720.0, 478303.0, 32484.0, 37035.444468332455, 38325.233495330496, 39208.607913920496, 39327.41008884812, 44253.11493770171, 44303.89240269019, 45095.77452112718, 45104.0, 45856.541434586565, 31639.0, 36833.44749828701, 36895.0, 37007.0, 37642.81178594199, 36422.0, 36443.63556364403, 37407.81296093502, 38052.0, 38237.0, 28743.85628071846, 35752.927412177676, 36285.27429451343, 36767.448488273236, 36788.0, 29874.701252987194, 32541.02376928696, 32695.346093078482, 32759.344813104082, 32861.83569082139, 20965.89517052405, 24352.63471047971, 24397.75602244026, 24726.876365618056, 24907.62638560459], "value": 19299.463692417045, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [346.5512161750533, 383.16661261755684, 385.3545311603066, 390.5469655199968, 412.72553751755083, 18948.419633494774, 20184.697229541533, 20587.588248235028, 20718.067686954084, 20722.27472038479, 20587.970601469904, 20834.791652083473, 21222.363329100113, 21385.358439246847, 21533.46166345842, 5547.55619550437, 5551.139573366135, 5799.246098007275, 5847.79532716355, 5923.17075609415, 5561.5828812839, 5872.17789509469, 5925.4370834770625, 5927.733252003649, 5941.88116237675, 5873.882522349571, 5980.372060933604, 5985.371535988724, 5990.071538911454, 5994.490468310199, 5903.645781253139, 5983.790567330145, 5988.640681559099, 6356.650384228866, 6427.903581446282, 5735.0, 5751.568632352591, 5752.194692743019, 5758.942410575883, 5761.5678824087945, 13330.533431329857, 17182.828171718375, 24096.638550421758, 25177.118800841883, 25480.23559293224, 2592.2741632342972, 2633.289011966758, 2664.9600255996174, 2669.986650066737, 2673.184678673004, 10098.29311948164, 10233.852729938631, 10451.738706532322, 11703.648890533297, 13602.115862469007, 1781.5011796696945, 1797.936255892322, 1800.2259028617689, 1801.4865763257408, 1857.823506766855, 126695.0, 128603.0, 130738.0, 132839.0, 138248.30875845658, 11340.546378144947, 11412.258203216765, 11767.352795596324, 11778.528858845722, 11944.820827687592, 15723.05661660304, 15741.134237616812, 15747.976381535163, 15779.842201578067, 15791.763123553155, 8024.277814996678, 8104.473209241381, 8204.876926846102, 8257.710980115668, 8351.958240208882, 6214.37856214384, 6861.656917154122, 7728.304452599181, 7764.650590723431, 7908.960455197687, 4022.356422972369, 4698.130845793539, 4776.665633405698, 4790.880227994328, 4887.926681099786, 1953.7922147972984, 1990.442676050708, 2009.6884982827685, 2010.266252817711, 2010.819026287612, 972.4602845420718, 979.7942432089341, 997.396575072071, 1011.8836333821705, 1013.4223492609142, 21401.78598214029, 21409.78590214109, 21826.626929939328, 21890.343289701334, 21896.12415503394, 1002.644061358222, 1010.4695035106481, 1011.1910471622673, 1024.902634249745, 1048.66442738323, 10872.586563746663, 11246.268992515461, 11264.38045907483, 11264.43677816106, 11309.604163854226, 615618.0, 615812.0, 616726.0, 642225.0, 675988.0, 146342.26828866, 147039.2648036753, 147918.0, 153172.0, 154696.0, 1008.3193844155165, 1012.473513772834, 1027.7790275090892, 1036.5231993283023, 1038.4184856480395, 18174.273029079217, 18784.06079696037, 18784.06079696037, 18869.43391698251, 19258.90370548138, 33446.832765836014, 35445.29109417849, 44847.32729009002, 55718.44281557295, 57106.0, 72153.0, 72196.0, 74532.0, 74698.81927156894, 74899.62550187214, 7114.893276600958, 7410.11078670563, 7787.532748035136, 8191.631376587949, 8438.240558349778, 11785.175037747618, 12503.124781265224, 12595.24428534291, 12919.870801291867, 13006.544770933351, 10554.0, 10939.617113400993, 11052.889471105185, 11108.722281943015, 11178.888211117785, 10759.623413180501, 10817.296875703054, 11036.0, 11128.666140015812, 11167.49746261404, 10999.560017599206, 11082.722931926766, 11153.609623663133, 11420.714482138013, 11507.827382589101, 7366.742164024234, 7459.962700186681, 7534.54792712439, 7642.770716878503, 7720.961395192988, 10250.794984100425, 10788.784224315626, 11130.276532025393, 11150.888491114985, 11201.943990279997], "value": 9658.375911936366, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1241.3296819717352, 1407.4933024111324, 1418.3475601223438, 1421.417218940234, 1439.5033713368887, 7225.710971561138, 7606.771796846097, 7896.0919494258105, 8160.714374996876, 8168.550729709864, 8072.475289106204, 8145.633446494907, 8160.183981601836, 8175.672973081085, 8226.136255693156, 1915.1477592471356, 2190.890455477224, 2231.3975226688785, 2232.944176395587, 2237.697910782048, 1995.4213278149318, 2186.2129633332065, 2249.3364457485, 2254.120892851789, 2272.7045484087043, 2195.220696652689, 2216.1689366487567, 2219.855709378893, 2224.899879505418, 2232.0, 2197.9340619781433, 2215.213599172303, 2220.877851718155, 2221.3447033125267, 2224.0325458425473, 2172.120291282033, 2187.3984654220058, 2228.5765704516252, 2231.0, 2235.0, 8154.0, 8205.466644668077, 8213.137620549816, 8233.423660343778, 8241.95879020607, 4876.122297986361, 5013.824516141917, 5019.071471777733, 5026.547610715017, 5042.798288068473, 2834.6456692913384, 3157.163351711798, 3290.045886692856, 3357.84889679965, 3358.899233023013, 1126.1272513801787, 1176.864660564029, 1216.519474807455, 1219.6584956212275, 1221.0109811053076, 10122.29143959923, 10474.319169253975, 10483.895161048367, 10580.523876425503, 10613.946930265376, 4162.2716024696165, 4176.0603864130935, 4344.543822898613, 4350.891227719269, 4362.585554372329, 8361.498310101413, 8380.706675266336, 8389.286910612665, 8393.748187554384, 8406.369522285853, 4873.878153046131, 4916.70499770015, 4932.4327702314695, 4944.90110197794, 4953.777080031407, 3956.4263181838473, 4307.987622908614, 4629.86110416688, 4632.884177895579, 4646.094011667692, 3429.6570342965506, 3466.5493485847182, 3468.9653103469145, 3546.716262698978, 3551.733619978512, 955.6225291010012, 1100.9174311926638, 1106.3748981825242, 1109.4674556213063, 1113.6714669172613, 870.3863776037878, 873.5094877787892, 874.8775171475999, 888.7378223424106, 915.057490784493, 5284.603654725911, 5485.6434331768305, 5507.228987941691, 5508.228847961289, 5640.802571910045, 537.8494021673938, 548.8463230295523, 553.593109064837, 570.8087790590116, 572.9054705973551, 3357.8247613335625, 3508.6315936826268, 3665.2669466106886, 3668.4497325401403, 3691.2248427830455, 9199.172074513326, 9497.287703422271, 9579.664711735195, 9608.039196080475, 9613.230941524662, 7300.853982920312, 9457.574409151604, 9483.336166468282, 9580.377275477073, 9603.327767056238, 7352.485326027127, 7542.622868856535, 7571.924280757122, 7573.35626471756, 7587.241275872479, 5223.373195216598, 5315.574754019746, 5316.760745766527, 5674.092145256739, 5677.148427735872, 8347.457415267989, 9079.818403631758, 9089.727308180765, 9098.499582523025, 9101.180893719596, 7556.4710470266555, 8962.68630597926, 9176.174144326775, 9188.127127922837, 9188.254231695957, 5888.733922206575, 6292.2134733158355, 6515.804525864231, 7035.366816986496, 7058.54119482232, 7068.611226382598, 7640.235976402315, 7702.998610180641, 7761.0, 7772.727954521564, 6822.317768223138, 6908.412784913338, 6950.339717726808, 7059.929400705927, 7096.929030709627, 6840.0, 6847.0, 6860.03959445688, 6873.48448866347, 6920.411765000032, 5465.754041068241, 6033.637981721111, 6242.500599951902, 6320.0, 6321.1782468278825, 4760.619150468024, 4803.975980120077, 4814.542618451242, 4857.975710121426, 4976.776045078052, 4883.780229889735, 4920.729359885097, 4939.777710002986, 4990.426100998432, 4991.3511243538105], "value": 4166.619689301496, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [353.2687337211971, 353.3551268934196, 367.8510203367636, 369.6229845557533, 371.4001886952572, 4673.696209746364, 5248.580113590913, 5270.65455872137, 5307.699613594665, 5319.840404787853, 4389.648828093753, 4881.999190166016, 5162.896742065156, 5215.426303106655, 5255.395629502608, 3515.2266501369722, 3998.8403363024686, 4020.8190631421658, 4060.675145988314, 4082.4896887889013, 3242.492241107884, 3592.9640703593022, 4054.452648892406, 4073.9388909166387, 4093.692973027035, 3528.7592378839363, 3736.4021756518828, 3929.5088113985753, 4052.675785937133, 4070.4301397804184, 3662.846203445906, 3942.7974467787312, 3949.98025009876, 3957.3074711925296, 3976.421220901183, 3023.818570885754, 3074.6925307469296, 3208.454562724319, 3451.066593395619, 3473.2879759649213, 4984.651074424792, 5122.257272695439, 5127.512886275797, 5152.92270615941, 5165.845024649267, 4406.537313582092, 4461.04087621163, 4519.0, 4519.0961807638605, 4523.36672865799, 4638.721676699375, 5459.8362049138195, 5465.098258787295, 5481.643693159932, 5529.557635389159, 3373.578302712161, 3794.867179648699, 3801.5818259991656, 3837.290101331235, 3843.730938834283, 3908.7850168240734, 5438.9937861495355, 5713.6000479966415, 5801.88396232073, 5829.912551311733, 3519.384107781128, 3578.1233597768714, 3818.2936156810524, 3823.5220597425323, 3860.841747475746, 3896.473976013202, 3922.843086276574, 3923.136510157652, 3933.6066393361007, 3937.468441760383, 3591.4792355108884, 3810.9809450952566, 4324.0, 4518.582558331277, 4571.405717256735, 5061.936993231463, 5117.718525481134, 5405.2163135985, 5577.860553486195, 5595.804146854841, 1182.2788099259444, 1210.7033776724759, 1258.4085479824469, 1277.2783377391745, 1277.4187744576195, 783.9098503672151, 801.8797180422984, 845.8285274894316, 862.2195166980166, 875.9737207883774, 4032.03231224504, 4218.704690671623, 4684.789184486706, 4718.646101542329, 4979.975100124549, 4773.809047638125, 5115.7442127893455, 5229.058769421465, 5334.8933021340135, 5514.834554963358, 4470.843520476833, 4500.611903394164, 4575.611073058761, 4633.791479383436, 4950.727709975914, 2423.97576024241, 2557.4629327841362, 2583.9741602583736, 2665.5735082386727, 2746.717672381485, 4991.0, 5412.269343638558, 5578.63738856973, 5687.1753595729215, 5725.627834190765, 5035.446100928895, 5580.386157522669, 5627.229756063447, 5631.63394379364, 5812.722259959234, 5437.31443252593, 5628.662280263197, 5861.88276234473, 5895.322037965689, 5945.908127773533, 5553.694546799965, 5664.122061080539, 5690.71546422669, 5695.401982791747, 5771.0, 4773.71357718538, 5339.7597108131, 5627.214528808267, 5637.434967089882, 5646.520045796154, 4980.327655766425, 5939.881202376015, 5952.8809423812145, 5967.791127310524, 6029.457348838626, 3443.4876426044793, 3841.3277676407074, 3862.7059934922117, 3876.030992251937, 3886.6502014818802, 4866.756662166948, 5046.77289521965, 5383.5423988961375, 5690.886182276414, 5758.366579676316, 5296.788128474818, 5463.743339031966, 5536.861578460571, 5540.307461567304, 5589.506558400999, 5219.530242278213, 5297.973510132425, 5487.231787549826, 5517.420670829666, 5561.6663000220115, 4843.128236917389, 4906.650671065486, 5116.71858047796, 5229.320188375639, 5429.53848922846, 5545.500904918576, 5563.165525171256, 5574.860628484158, 5578.2748242728185, 5578.86052848682, 4937.580305674058, 5009.5992320615, 5052.242163675478, 5298.0, 5479.0], "value": 3989.9524536426866, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [672.8519725660353, 696.3558708194921, 743.3904198557182, 775.9146493885672, 788.2905385153363, 14312.427502899884, 14988.250587470637, 15012.174330411823, 15021.248937553133, 15034.323455444517, 13633.522826701068, 13734.58796236112, 13738.725225495484, 13760.862391376084, 13813.102148360349, 856.9485830850138, 871.6774793326479, 888.4802390601474, 892.0811564088999, 897.896741874683, 879.7668617816283, 893.0578239956843, 893.1024320557831, 894.8299823033635, 894.9865752013725, 832.8251067275849, 897.9371443998923, 907.3603109807602, 939.065629698451, 942.4580866002042, 888.7467071884482, 924.3945215883607, 933.1135421349677, 935.1163150822475, 941.3410612571193, 697.2643860726931, 699.1016543741318, 699.8390370214828, 699.9055127557816, 702.4310308650009, 14827.851721482755, 14867.776983345258, 14889.181095039768, 15022.24888755558, 15054.172020538866, 13717.0398072135, 13990.930045349709, 14019.509317173952, 14062.507812226626, 14084.0, 11433.42832858362, 11474.655760327203, 11554.248973816675, 11831.526738930519, 12059.97490213333, 3570.553680789901, 3591.2637909228547, 3622.5652921649307, 3733.757305775116, 3758.8120593970193, 99058.0, 100233.4988325061, 100476.9952300475, 100757.0, 101203.0, 10396.896031039743, 10487.108595769292, 10533.525991330409, 10704.19718521114, 10728.195385345975, 21798.56402871934, 22194.667079993815, 22240.999155037738, 22258.554828903332, 22330.330090097323, 7432.554046757212, 7502.099748030271, 7516.060492438445, 7582.962085189539, 7698.384129269645, 4099.364598487239, 4192.329227323614, 4200.327947528381, 4270.957290427056, 4310.353446982915, 3536.7524273300623, 3635.709143268532, 3637.399829028234, 3644.580873199563, 3649.799261040668, 640.6348381422545, 642.3095172689377, 654.8231977366084, 670.7216505150308, 672.0758956434902, 630.7256343490596, 651.4788169464409, 667.5860966200986, 670.0853335197518, 681.2097966358999, 8681.609327580274, 9482.525873706287, 9654.71035868925, 9932.900670993198, 10072.345297555636, 636.8280564247627, 648.7307767276621, 656.6093174561129, 661.6427129350097, 662.2880403566186, 4728.929066064012, 4809.831655892027, 4881.389826271716, 4894.8042078317185, 4936.308916751657, 101169.49415252877, 101691.4915425433, 101903.0, 102021.0, 103813.0, 47386.0, 75428.24571754212, 76093.6195319031, 85698.0, 89539.0, 68070.31929680739, 68159.0, 69465.0, 74203.0, 76628.0, 10301.124404425707, 10307.484625768531, 10507.632232871812, 10510.947445262726, 10542.367457952547, 36160.63839361573, 46300.1079093563, 46543.943346259795, 48232.517674822804, 49749.0, 68441.65779171072, 68579.0, 69207.65396172987, 69562.30437695558, 70588.0, 12399.00807935381, 12814.743705126031, 12825.551105711254, 12866.421011054337, 12911.22532648044, 12394.690132746753, 13958.930205348908, 14307.570772876414, 14371.640708982359, 15022.62443438879, 12982.675433114247, 13170.934145329595, 13230.933845330712, 13303.0, 13687.0, 11616.128790340927, 12845.807312890502, 12972.545960891324, 13108.475660973836, 13833.377498012815, 12790.744185116431, 12839.807402888777, 12931.676708081997, 12964.740705186032, 12969.546065888026, 8844.73465796027, 10956.671299861016, 10959.50682219318, 10966.725831854268, 11111.72220694489, 8537.274331681876, 8624.741257762276, 10362.585496580052, 10628.8937110631, 10660.360378377321], "value": 7358.728912010607, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1467.6, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [116.0, 115.0, 113.0, 115.0, 114.0, 115.0, 115.0, 114.0, 114.0, 114.0], "value": 114.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 140.0, 141.0, 146.0, 113.0, 110.0, 113.0, 107.0, 136.0, 137.0], "value": 131.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 184.0, 180.0, 185.0, 184.0, 181.0, 181.0, 182.0, 187.0], "value": 183.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 61.0, 102.0, 87.0, 85.0, 71.0, 60.0, 76.0, 58.0], "value": 74.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 72.0, 84.0, 67.0, 70.0, 70.0, 84.0, 69.0, 68.0, 83.0], "value": 75.4, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 89.0, 88.0, 87.0, 88.0, 88.0, 88.0, 87.0, 88.0, 87.0], "value": 87.9, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 95.0, 97.0, 95.0, 96.0, 96.0, 95.0, 110.0, 150.0, 95.0], "value": 102.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 87.0, 86.0, 85.0, 86.0, 85.0, 87.0, 85.0], "value": 85.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 58.0, 59.0, 59.0, 60.0, 60.0, 60.0, 60.0, 59.0, 59.0], "value": 59.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [64.0, 74.0, 77.0, 74.0, 72.0, 68.0, 69.0, 69.0, 69.0, 70.0], "value": 70.6, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 89.0, 89.0, 88.0, 89.0, 90.0, 88.0, 94.0, 88.0], "value": 89.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [147.0, 158.0, 141.0, 142.0, 139.0, 147.0, 146.0, 140.0, 175.0, 159.0], "value": 149.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 173.0, 172.0, 172.0, 172.0, 175.0, 168.0, 172.0, 217.0, 186.0], "value": 178.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 68.0, 68.0, 67.0, 65.0, 66.0, 64.0, 66.0, 66.0, 64.0], "value": 66.1, "unit": "score"}]}]} 04:10:46 INFO - Return code: 0 04:10:46 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:10:46 ERROR - # TBPL SUCCESS # 04:10:46 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:10:46 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:10:46 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:10:46 INFO - 2017-02-09 04:10:46.693 screenresolution[1656:9719] starting screenresolution argv=screenresolution get 04:10:46 INFO - 2017-02-09 04:10:46.696 screenresolution[1656:9719] Display 0: 1600x1200x32@60 04:10:46 INFO - 2017-02-09 04:10:46.702 screenresolution[1657:9722] starting screenresolution argv=screenresolution list 04:10:46 INFO - Available Modes on Display 0 04:10:46 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:10:46 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:10:46 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:10:46 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:10:46 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:10:46 INFO - Intel Iris: 04:10:46 INFO - Chipset Model: Intel Iris 04:10:46 INFO - Type: GPU 04:10:46 INFO - Bus: Built-In 04:10:46 INFO - VRAM (Dynamic, Max): 1536 MB 04:10:46 INFO - Vendor: Intel (0x8086) 04:10:46 INFO - Device ID: 0x0a2e 04:10:46 INFO - Revision ID: 0x0009 04:10:46 INFO - Displays: 04:10:46 INFO - Display: 04:10:46 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:10:46 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:10:46 INFO - Display Serial Number: 1600x1200 60 04:10:46 INFO - Main Display: Yes 04:10:46 INFO - Mirror: Off 04:10:46 INFO - Online: Yes 04:10:46 INFO - Rotation: Supported 04:10:46 INFO - Return code: 0 04:10:46 INFO - Running post-action listener: _resource_record_post_action 04:10:46 INFO - [mozharness: 2017-02-09 12:10:46.939054Z] Finished run-tests step (success) 04:10:46 INFO - Running post-run listener: _resource_record_post_run 04:10:46 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 37995520; Write bytes: 554201600; Read time: 245; Write time: 1683 04:10:46 INFO - TinderboxPrint: CPU usage
53.8% 04:10:46 INFO - TinderboxPrint: I/O read bytes / time
37,995,520 / 245 04:10:46 INFO - TinderboxPrint: I/O write bytes / time
554,201,600 / 1,683 04:10:46 INFO - TinderboxPrint: CPU idle
2,221.5 (46.2%) 04:10:46 INFO - TinderboxPrint: CPU system
957.1 (19.9%) 04:10:46 INFO - TinderboxPrint: CPU user
1,627.1 (33.9%) 04:10:46 INFO - TinderboxPrint: Swap in / out
290,222,080 / 0 04:10:46 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 250767872; Write bytes: 243064832; Read time: 17986; Write time: 502 04:10:47 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 34485248; Write bytes: 299704832; Read time: 223; Write time: 1141 04:10:47 INFO - Running post-run listener: _upload_blobber_files 04:10:47 INFO - Blob upload gear active. 04:10:47 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:10:47 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:10:47 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:10:47 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:10:47 INFO - (blobuploader) - INFO - Open directory for files ... 04:10:47 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:10:47 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:47 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:49 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:10:49 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:49 INFO - (blobuploader) - INFO - Done attempting. 04:10:49 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:10:49 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:49 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:50 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:10:50 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:50 INFO - (blobuploader) - INFO - Done attempting. 04:10:50 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:10:50 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:50 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:51 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:10:51 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:51 INFO - (blobuploader) - INFO - Done attempting. 04:10:51 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:10:51 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:10:51 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:10:53 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:10:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:10:53 INFO - (blobuploader) - INFO - Done attempting. 04:10:53 INFO - (blobuploader) - INFO - Iteration through files over. 04:10:53 INFO - Return code: 0 04:10:53 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:10:53 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:10:53 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/618026c11f90cb2f67084c4484974fc906f59d6945c62d03b42c22bd2ed36f7f57b641104ebef776c690f69d26f6d9c9572ac4de6e471940ee9f8f8d8725dc4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fb731b7e483acec7016f69ae263f12d3badf31dae40320235688614daa830587e9d29acbaffb09a2e3b7bd64bd7b09916c6373101157df2654ce8720c2e073f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd00a2c29a59321ca23b0eef2f618616f2538825a964821fb63db01443211c09e334f14ff42091d8d800064f3d1081ed8b55039d3c7acddef6958e92c7e42943", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d01a639718dde2eb1363b764a22343925930dcc53f1ce6d91f801e00afc4ed483ebbced25eec29b39cbd6a50901121459d43a6d583aae27c67a752f93983765d"} 04:10:53 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:10:53 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:10:53 INFO - Contents: 04:10:53 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/618026c11f90cb2f67084c4484974fc906f59d6945c62d03b42c22bd2ed36f7f57b641104ebef776c690f69d26f6d9c9572ac4de6e471940ee9f8f8d8725dc4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fb731b7e483acec7016f69ae263f12d3badf31dae40320235688614daa830587e9d29acbaffb09a2e3b7bd64bd7b09916c6373101157df2654ce8720c2e073f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd00a2c29a59321ca23b0eef2f618616f2538825a964821fb63db01443211c09e334f14ff42091d8d800064f3d1081ed8b55039d3c7acddef6958e92c7e42943", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d01a639718dde2eb1363b764a22343925930dcc53f1ce6d91f801e00afc4ed483ebbced25eec29b39cbd6a50901121459d43a6d583aae27c67a752f93983765d"} 04:10:53 INFO - Running post-run listener: copy_logs_to_upload_dir 04:10:53 INFO - Copying logs to upload dir... 04:10:53 INFO - mkdir: /builds/slave/test/build/upload/logs 04:10:53 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1264.860782 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 4 secs) (at 2017-02-09 04:10:53.688837) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 04:10:53.692486) ========= 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.cyyrTACCAJ/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.QKLCf1FEbt/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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/618026c11f90cb2f67084c4484974fc906f59d6945c62d03b42c22bd2ed36f7f57b641104ebef776c690f69d26f6d9c9572ac4de6e471940ee9f8f8d8725dc4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fb731b7e483acec7016f69ae263f12d3badf31dae40320235688614daa830587e9d29acbaffb09a2e3b7bd64bd7b09916c6373101157df2654ce8720c2e073f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd00a2c29a59321ca23b0eef2f618616f2538825a964821fb63db01443211c09e334f14ff42091d8d800064f3d1081ed8b55039d3c7acddef6958e92c7e42943", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d01a639718dde2eb1363b764a22343925930dcc53f1ce6d91f801e00afc4ed483ebbced25eec29b39cbd6a50901121459d43a6d583aae27c67a752f93983765d"} build_url:https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010945 build_url: 'https://queue.taskcluster.net/v1/task/OfSroXjURveNKqAuKyq7Hw/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/618026c11f90cb2f67084c4484974fc906f59d6945c62d03b42c22bd2ed36f7f57b641104ebef776c690f69d26f6d9c9572ac4de6e471940ee9f8f8d8725dc4e", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/7fb731b7e483acec7016f69ae263f12d3badf31dae40320235688614daa830587e9d29acbaffb09a2e3b7bd64bd7b09916c6373101157df2654ce8720c2e073f", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cd00a2c29a59321ca23b0eef2f618616f2538825a964821fb63db01443211c09e334f14ff42091d8d800064f3d1081ed8b55039d3c7acddef6958e92c7e42943", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d01a639718dde2eb1363b764a22343925930dcc53f1ce6d91f801e00afc4ed483ebbced25eec29b39cbd6a50901121459d43a6d583aae27c67a752f93983765d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-02-09 04:10:53.727220) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:10:53.727620) ========= 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.cyyrTACCAJ/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.QKLCf1FEbt/Listeners TMPDIR=/var/folders/r4/175kjq1972gggq8bl2fbwrf400000w/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.005132 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-02-09 04:10:53.776302) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 04:10:53.776679) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-02-09 04:10:53.777070) ========= ========= Total master_lag: 0.18 =========