builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0038 starttime: 1488541874.53 results: success (0) buildid: 20170303022739 builduid: cff831180cf148d99240155ba54267ea revision: 9732cd019a8b94c49a275661320c1b742635a3d6 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 03:51:14.530914) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-03 03:51:14.531366) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 03:51:14.531636) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-03 03:51:14.556663) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 03:51:14.557209) ========= 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.bBjd9sJJZh/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.jWrsDST7R2/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-03 03:51:14-- 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% 41.0M=0s 2017-03-03 03:51:14 (41.0 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.107851 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 03:51:14.689178) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 03:51:14.689495) ========= 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.bBjd9sJJZh/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.jWrsDST7R2/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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.020010 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 03:51:14.737660) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-03 03:51:14.738016) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 9732cd019a8b94c49a275661320c1b742635a3d6 --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 9732cd019a8b94c49a275661320c1b742635a3d6 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.bBjd9sJJZh/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.jWrsDST7R2/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-03 03:51:14,828 truncating revision to first 12 chars 2017-03-03 03:51:14,828 Setting DEBUG logging. 2017-03-03 03:51:14,828 attempt 1/10 2017-03-03 03:51:14,828 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/9732cd019a8b?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-03 03:51:16,207 unpacking tar archive at: mozilla-central-9732cd019a8b/testing/mozharness/ program finished with exit code 0 elapsedTime=1.955971 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-03 03:51:16.717382) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 03:51:16.717703) ========= script_repo_revision: 9732cd019a8b94c49a275661320c1b742635a3d6 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-03 03:51:16.721120) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 03:51:16.721412) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-03 03:51:16.741665) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-03 03:51:16.742032) ========= /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.bBjd9sJJZh/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.jWrsDST7R2/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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:51:16 INFO - MultiFileLogger online at 20170303 03:51:16 in /builds/slave/test 03:51:16 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:51:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:51:16 INFO - {'append_to_log': False, 03:51:16 INFO - 'base_work_dir': '/builds/slave/test', 03:51:16 INFO - 'blob_upload_branch': 'Firefox', 03:51:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:51:16 INFO - 'branch': 'Firefox', 03:51:16 INFO - 'buildbot_json_path': 'buildprops.json', 03:51:16 INFO - 'config_files': ('talos/mac_config.py',), 03:51:16 INFO - 'default_actions': ('clobber', 03:51:16 INFO - 'read-buildbot-config', 03:51:16 INFO - 'download-and-extract', 03:51:16 INFO - 'populate-webroot', 03:51:16 INFO - 'create-virtualenv', 03:51:16 INFO - 'install', 03:51:16 INFO - 'run-tests'), 03:51:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:51:16 INFO - 'download_minidump_stackwalk': True, 03:51:16 INFO - 'download_symbols': 'ondemand', 03:51:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:51:16 INFO - 'tooltool.py': '/tools/tooltool.py', 03:51:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:51:16 INFO - '/tools/misc-python/virtualenv.py')}, 03:51:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:51:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:51:16 INFO - 'gecko_profile': False, 03:51:16 INFO - 'gecko_profile_interval': 0, 03:51:16 INFO - 'installer_path': 'installer.exe', 03:51:16 INFO - 'log_level': 'info', 03:51:16 INFO - 'log_name': 'talos', 03:51:16 INFO - 'log_to_console': True, 03:51:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:51:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:51:16 INFO - 'opt_config_files': (), 03:51:16 INFO - 'pip_index': False, 03:51:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:51:16 INFO - 'cmd': ('bash', 03:51:16 INFO - '-c', 03:51:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:51:16 INFO - 'enabled': True, 03:51:16 INFO - 'halt_on_failure': False, 03:51:16 INFO - 'name': 'check_screen_resolution'},), 03:51:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:51:16 INFO - 'cmd': ('bash', 03:51:16 INFO - '-c', 03:51:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:51:16 INFO - 'enabled': True, 03:51:16 INFO - 'halt_on_failure': False, 03:51:16 INFO - 'name': 'check_screen_resolution'},), 03:51:16 INFO - 'run_cmd_checks_enabled': True, 03:51:16 INFO - 'suite': 'dromaeojs', 03:51:16 INFO - 'system_bits': '32', 03:51:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:51:16 INFO - 'title': 't-yosemite-r7-0038', 03:51:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:51:16 INFO - 'use_talos_json': True, 03:51:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:51:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:51:16 INFO - 'work_dir': 'build'} 03:51:16 INFO - [mozharness: 2017-03-03 11:51:16.952985Z] Running clobber step. 03:51:16 INFO - Running pre-action listener: _resource_record_pre_action 03:51:16 INFO - Running main action method: clobber 03:51:16 INFO - rmtree: /builds/slave/test/build 03:51:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:51:18 INFO - Running post-action listener: _resource_record_post_action 03:51:18 INFO - [mozharness: 2017-03-03 11:51:18.638762Z] Finished clobber step (success) 03:51:18 INFO - [mozharness: 2017-03-03 11:51:18.638896Z] Running read-buildbot-config step. 03:51:18 INFO - Running pre-action listener: _resource_record_pre_action 03:51:18 INFO - Running main action method: read_buildbot_config 03:51:18 INFO - Using buildbot properties: 03:51:18 INFO - { 03:51:18 INFO - "project": "", 03:51:18 INFO - "product": "firefox", 03:51:18 INFO - "script_repo_revision": "production", 03:51:18 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:51:18 INFO - "repository": "", 03:51:18 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:51:18 INFO - "buildid": "20170303022739", 03:51:18 INFO - "pgo_build": "False", 03:51:18 INFO - "basedir": "/builds/slave/test", 03:51:18 INFO - "buildnumber": 1, 03:51:18 INFO - "slavename": "t-yosemite-r7-0038", 03:51:18 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 03:51:18 INFO - "platform": "yosemite_r7", 03:51:18 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:51:18 INFO - "branch": "mozilla-central", 03:51:18 INFO - "repo_path": "mozilla-central", 03:51:18 INFO - "revision": "9732cd019a8b94c49a275661320c1b742635a3d6", 03:51:18 INFO - "stage_platform": "macosx64", 03:51:18 INFO - "builduid": "cff831180cf148d99240155ba54267ea", 03:51:18 INFO - "slavebuilddir": "test" 03:51:18 INFO - } 03:51:18 INFO - Found installer url https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 03:51:18 INFO - Running post-action listener: _resource_record_post_action 03:51:18 INFO - [mozharness: 2017-03-03 11:51:18.642261Z] Finished read-buildbot-config step (success) 03:51:18 INFO - [mozharness: 2017-03-03 11:51:18.642348Z] Running download-and-extract step. 03:51:18 INFO - Running pre-action listener: _resource_record_pre_action 03:51:18 INFO - Running main action method: download_and_extract 03:51:18 INFO - mkdir: /builds/slave/test/build/tests 03:51:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:18 INFO - trying https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 03:51:18 INFO - Downloading https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/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:51:18 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/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:51:20 INFO - Downloaded 1199 bytes. 03:51:20 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 03:51:20 INFO - Using the following test package requirements: 03:51:20 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 03:51:20 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:51:20 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 03:51:20 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:51:20 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 03:51:20 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:51:20 INFO - u'jsshell-mac.zip'], 03:51:20 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:51:20 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 03:51:20 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 03:51:20 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:51:20 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 03:51:20 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:51:20 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 03:51:20 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:51:20 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 03:51:20 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 03:51:20 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 03:51:20 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:51:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 03:51:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:51:20 INFO - Fetch https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 03:51:21 INFO - Expected file size: 51768505 03:51:21 INFO - Obtained file size: 51768505 03:51:38 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:51:38 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 03:51:38 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:51:38 INFO - Fetch https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 03:51:40 INFO - Expected file size: 51768505 03:51:40 INFO - Obtained file size: 51768505 03:51:55 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 03:51:55 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:51:55 INFO - Fetch https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 03:51:56 INFO - Expected file size: 14404424 03:51:56 INFO - Obtained file size: 14404424 03:51:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:51:57 INFO - trying https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:51:57 INFO - Downloading https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 03:51:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/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:51:59 INFO - Downloaded 75021402 bytes. 03:51:59 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:51:59 INFO - mkdir: /builds/slave/test/properties 03:51:59 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:51:59 INFO - Writing to file /builds/slave/test/properties/build_url 03:51:59 INFO - Contents: 03:51:59 INFO - build_url:https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 03:51:59 INFO - Running post-action listener: _resource_record_post_action 03:51:59 INFO - Running post-action listener: set_extra_try_arguments 03:51:59 INFO - [mozharness: 2017-03-03 11:51:59.978226Z] Finished download-and-extract step (success) 03:51:59 INFO - [mozharness: 2017-03-03 11:51:59.978357Z] Running populate-webroot step. 03:51:59 INFO - Running pre-action listener: _resource_record_pre_action 03:51:59 INFO - Running main action method: populate_webroot 03:51:59 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:51:59 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:51:59 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:51:59 INFO - '--tppagecycles', 03:51:59 INFO - '7'], 03:51:59 INFO - 'tests': ['tsvgm']}}, 03:51:59 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:51:59 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:51:59 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:51:59 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:51:59 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:51:59 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:51:59 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:51:59 INFO - 'talos_options': ['--disable-e10s'], 03:51:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:51:59 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:51:59 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:51:59 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:51:59 INFO - 'talos_options': ['--disable-e10s'], 03:51:59 INFO - 'tests': ['damp', 'tps']}, 03:51:59 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:51:59 INFO - 'tests': ['damp', 'tps']}, 03:51:59 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:51:59 INFO - 'tests': ['dromaeo_dom']}, 03:51:59 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:51:59 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:51:59 INFO - 'tests': ['basic_compositor_video']}, 03:51:59 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:51:59 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:51:59 INFO - 'tests': ['a11yr', 03:51:59 INFO - 'ts_paint', 03:51:59 INFO - 'tpaint', 03:51:59 INFO - 'sessionrestore', 03:51:59 INFO - 'sessionrestore_no_auto_restore', 03:51:59 INFO - 'tabpaint']}, 03:51:59 INFO - 'other-e10s': {'tests': ['a11yr', 03:51:59 INFO - 'ts_paint', 03:51:59 INFO - 'tpaint', 03:51:59 INFO - 'sessionrestore', 03:51:59 INFO - 'sessionrestore_no_auto_restore', 03:51:59 INFO - 'tabpaint']}, 03:51:59 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:51:59 INFO - 'ts_paint', 03:51:59 INFO - 'tpaint', 03:51:59 INFO - 'sessionrestore', 03:51:59 INFO - 'sessionrestore_no_auto_restore', 03:51:59 INFO - 'tabpaint']}, 03:51:59 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:51:59 INFO - 'ts_paint', 03:51:59 INFO - 'tpaint', 03:51:59 INFO - 'sessionrestore', 03:51:59 INFO - 'sessionrestore_no_auto_restore', 03:51:59 INFO - 'tabpaint']}, 03:51:59 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:51:59 INFO - 'tests': ['a11yr', 03:51:59 INFO - 'ts_paint', 03:51:59 INFO - 'tpaint', 03:51:59 INFO - 'sessionrestore', 03:51:59 INFO - 'sessionrestore_no_auto_restore', 03:51:59 INFO - 'tabpaint']}, 03:51:59 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:51:59 INFO - 'tests': ['a11yr', 03:51:59 INFO - 'ts_paint', 03:51:59 INFO - 'tpaint', 03:51:59 INFO - 'sessionrestore', 03:51:59 INFO - 'sessionrestore_no_auto_restore', 03:51:59 INFO - 'tabpaint']}, 03:51:59 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:51:59 INFO - 'tests': ['tsvgx', 03:51:59 INFO - 'tsvgr_opacity', 03:51:59 INFO - 'tart', 03:51:59 INFO - 'tscrollx', 03:51:59 INFO - 'cart', 03:51:59 INFO - 'tsvg_static']}, 03:51:59 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:51:59 INFO - 'tsvgr_opacity', 03:51:59 INFO - 'tart', 03:51:59 INFO - 'tscrollx', 03:51:59 INFO - 'cart', 03:51:59 INFO - 'tsvg_static']}, 03:51:59 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:51:59 INFO - 'talos_options': ['--disable-e10s'], 03:51:59 INFO - 'tests': ['tp5o']}, 03:51:59 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:51:59 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:51:59 INFO - 'talos_options': ['--disable-e10s', 03:51:59 INFO - '--xperf_path', 03:51:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:51:59 INFO - 'tests': ['tp5n']}, 03:51:59 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:51:59 INFO - 'talos_options': ['--xperf_path', 03:51:59 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:51:59 INFO - 'tests': ['tp5n']}}, 03:51:59 INFO - 'talos.zip': {'path': '', 03:51:59 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:51:59 INFO - Running post-action listener: _resource_record_post_action 03:51:59 INFO - [mozharness: 2017-03-03 11:51:59.996499Z] Finished populate-webroot step (success) 03:51:59 INFO - [mozharness: 2017-03-03 11:51:59.996630Z] Running create-virtualenv step. 03:51:59 INFO - Running pre-action listener: _resource_record_pre_action 03:51:59 INFO - Running main action method: create_virtualenv 03:51:59 INFO - Creating virtualenv /builds/slave/test/build/venv 03:51:59 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:51:59 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:52:00 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:52:00 INFO - Using real prefix '/tools/python27' 03:52:00 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:52:00 INFO - Installing distribute.............................................................................................................................................................................................done. 03:52:03 INFO - Installing pip.................done. 03:52:03 INFO - Return code: 0 03:52:03 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:52:03 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:52:03 INFO - Reading from file tmpfile_stdout 03:52:03 INFO - Output received: 03:52:03 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:52:03 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:52:03 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:52:03 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:03 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:03 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:52:03 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:03 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:03 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 0x104f68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff492d6adb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d46d30>, '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 0x104c6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d3bbe8>, '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.bBjd9sJJZh/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.jWrsDST7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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:52:03 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:52:03 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:52:03 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBjd9sJJZh/Render', 03:52:03 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:03 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:03 INFO - 'HOME': '/Users/cltbld', 03:52:03 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:03 INFO - 'LOGNAME': 'cltbld', 03:52:03 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:03 INFO - 'MOZ_NO_REMOTE': '1', 03:52:03 INFO - 'NO_EM_RESTART': '1', 03:52:03 INFO - 'PAGER': '/bin/cat', 03:52:03 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:03 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:03 INFO - 'PWD': '/builds/slave/test', 03:52:03 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:03 INFO - 'SHELL': '/bin/bash', 03:52:03 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWrsDST7R2/Listeners', 03:52:03 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 03:52:03 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:03 INFO - 'USER': 'cltbld', 03:52:03 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:03 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:03 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:03 INFO - 'XPC_FLAGS': '0x0', 03:52:03 INFO - 'XPC_SERVICE_NAME': '0', 03:52:03 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:04 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 03:52:04 INFO - Cleaning up... 03:52:04 INFO - Return code: 0 03:52:04 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:04 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:04 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff492d6adb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d46d30>, '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 0x104c6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d3bbe8>, '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.bBjd9sJJZh/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.jWrsDST7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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:52:04 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:52:04 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:52:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBjd9sJJZh/Render', 03:52:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:04 INFO - 'HOME': '/Users/cltbld', 03:52:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:04 INFO - 'LOGNAME': 'cltbld', 03:52:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:04 INFO - 'MOZ_NO_REMOTE': '1', 03:52:04 INFO - 'NO_EM_RESTART': '1', 03:52:04 INFO - 'PAGER': '/bin/cat', 03:52:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:04 INFO - 'PWD': '/builds/slave/test', 03:52:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:04 INFO - 'SHELL': '/bin/bash', 03:52:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWrsDST7R2/Listeners', 03:52:04 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 03:52:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:04 INFO - 'USER': 'cltbld', 03:52:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:04 INFO - 'XPC_FLAGS': '0x0', 03:52:04 INFO - 'XPC_SERVICE_NAME': '0', 03:52:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:04 INFO - Downloading/unpacking psutil>=3.1.1 03:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:07 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:52:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:08 INFO - Installing collected packages: psutil 03:52:08 INFO - Running setup.py install for psutil 03:52:08 INFO - building 'psutil._psutil_osx' extension 03:52:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 03:52:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 03:52:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 03:52:08 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 03:52:08 INFO - building 'psutil._psutil_posix' extension 03:52:08 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 03:52:08 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:52:08 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:52:08 INFO - ^ 03:52:08 INFO - 1 warning generated. 03:52:08 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 03:52:08 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:52:08 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:52:08 INFO - Successfully installed psutil 03:52:08 INFO - Cleaning up... 03:52:08 INFO - Return code: 0 03:52:08 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:52:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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:52:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:09 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x104f68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff492d6adb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d46d30>, '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 0x104c6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d3bbe8>, '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.bBjd9sJJZh/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.jWrsDST7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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:52:09 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 03:52:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 03:52:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBjd9sJJZh/Render', 03:52:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:09 INFO - 'HOME': '/Users/cltbld', 03:52:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:09 INFO - 'LOGNAME': 'cltbld', 03:52:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:09 INFO - 'MOZ_NO_REMOTE': '1', 03:52:09 INFO - 'NO_EM_RESTART': '1', 03:52:09 INFO - 'PAGER': '/bin/cat', 03:52:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:09 INFO - 'PWD': '/builds/slave/test', 03:52:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:09 INFO - 'SHELL': '/bin/bash', 03:52:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWrsDST7R2/Listeners', 03:52:09 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 03:52:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:09 INFO - 'USER': 'cltbld', 03:52:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:09 INFO - 'XPC_FLAGS': '0x0', 03:52:09 INFO - 'XPC_SERVICE_NAME': '0', 03:52:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:09 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:09 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:12 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:52:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:52:12 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:52:12 INFO - Installing collected packages: mozsystemmonitor 03:52:12 INFO - Running setup.py install for mozsystemmonitor 03:52:12 INFO - Successfully installed mozsystemmonitor 03:52:12 INFO - Cleaning up... 03:52:12 INFO - Return code: 0 03:52:12 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x104f68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff492d6adb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d46d30>, '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 0x104c6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d3bbe8>, '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.bBjd9sJJZh/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.jWrsDST7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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:52:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:52:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:52:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBjd9sJJZh/Render', 03:52:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:12 INFO - 'HOME': '/Users/cltbld', 03:52:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:12 INFO - 'LOGNAME': 'cltbld', 03:52:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:12 INFO - 'MOZ_NO_REMOTE': '1', 03:52:12 INFO - 'NO_EM_RESTART': '1', 03:52:12 INFO - 'PAGER': '/bin/cat', 03:52:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:12 INFO - 'PWD': '/builds/slave/test', 03:52:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:12 INFO - 'SHELL': '/bin/bash', 03:52:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWrsDST7R2/Listeners', 03:52:12 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 03:52:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:12 INFO - 'USER': 'cltbld', 03:52:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:12 INFO - 'XPC_FLAGS': '0x0', 03:52:12 INFO - 'XPC_SERVICE_NAME': '0', 03:52:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:12 INFO - Downloading/unpacking jsonschema==2.5.1 03:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:15 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:52:15 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:52:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:52:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:52:15 INFO - Downloading functools32-3.2.3-2.tar.gz 03:52:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:52:16 INFO - warning: no files found matching '*.txt' 03:52:16 INFO - no previously-included directories found matching 'build' 03:52:16 INFO - no previously-included directories found matching 'dist' 03:52:16 INFO - no previously-included directories found matching '.git*' 03:52:16 INFO - Installing collected packages: jsonschema, functools32 03:52:16 INFO - Running setup.py install for functools32 03:52:16 INFO - warning: no files found matching '*.txt' 03:52:16 INFO - no previously-included directories found matching 'build' 03:52:16 INFO - no previously-included directories found matching 'dist' 03:52:16 INFO - no previously-included directories found matching '.git*' 03:52:16 INFO - Successfully installed jsonschema functools32 03:52:16 INFO - Cleaning up... 03:52:16 INFO - Return code: 0 03:52:16 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:52: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:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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', '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 0x104f68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff492d6adb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d46d30>, '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 0x104c6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d3bbe8>, '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.bBjd9sJJZh/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.jWrsDST7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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:52: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', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:52: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 functools32==3.2.3-2 03:52:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBjd9sJJZh/Render', 03:52:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:16 INFO - 'HOME': '/Users/cltbld', 03:52:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:16 INFO - 'LOGNAME': 'cltbld', 03:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:16 INFO - 'MOZ_NO_REMOTE': '1', 03:52:16 INFO - 'NO_EM_RESTART': '1', 03:52:16 INFO - 'PAGER': '/bin/cat', 03:52:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:16 INFO - 'PWD': '/builds/slave/test', 03:52:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:16 INFO - 'SHELL': '/bin/bash', 03:52:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWrsDST7R2/Listeners', 03:52:16 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 03:52:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:16 INFO - 'USER': 'cltbld', 03:52:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:16 INFO - 'XPC_FLAGS': '0x0', 03:52:16 INFO - 'XPC_SERVICE_NAME': '0', 03:52:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:16 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:52:16 INFO - Cleaning up... 03:52:16 INFO - Return code: 0 03:52:16 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:52: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:52:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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:52:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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', '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 0x104f68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff492d6adb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d46d30>, '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 0x104c6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d3bbe8>, '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.bBjd9sJJZh/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.jWrsDST7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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:52: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', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:52: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 blobuploader==1.2.4 03:52:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBjd9sJJZh/Render', 03:52:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:16 INFO - 'HOME': '/Users/cltbld', 03:52:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:16 INFO - 'LOGNAME': 'cltbld', 03:52:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:16 INFO - 'MOZ_NO_REMOTE': '1', 03:52:16 INFO - 'NO_EM_RESTART': '1', 03:52:16 INFO - 'PAGER': '/bin/cat', 03:52:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:16 INFO - 'PWD': '/builds/slave/test', 03:52:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:16 INFO - 'SHELL': '/bin/bash', 03:52:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWrsDST7R2/Listeners', 03:52:16 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 03:52:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:16 INFO - 'USER': 'cltbld', 03:52:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:16 INFO - 'XPC_FLAGS': '0x0', 03:52:16 INFO - 'XPC_SERVICE_NAME': '0', 03:52:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:16 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:16 INFO - Downloading/unpacking blobuploader==1.2.4 03:52: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:52: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:52: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:52: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:52: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:52: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:52:19 INFO - Downloading blobuploader-1.2.4.tar.gz 03:52:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:52:19 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:52:19 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:52:19 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:52:19 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:52:19 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:52:19 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:52:19 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:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:52:20 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:52:20 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:52:20 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:52:20 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:52:20 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:52:20 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:52:20 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:52:20 INFO - Downloading docopt-0.6.1.tar.gz 03:52:20 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:52:20 INFO - Installing collected packages: blobuploader, requests, docopt 03:52:20 INFO - Running setup.py install for blobuploader 03:52:20 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:52:20 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:52:20 INFO - Running setup.py install for requests 03:52:21 INFO - Running setup.py install for docopt 03:52:21 INFO - Successfully installed blobuploader requests docopt 03:52:21 INFO - Cleaning up... 03:52:21 INFO - Return code: 0 03:52:21 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52: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:52:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52: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:52:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:21 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 0x104f68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff492d6adb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d46d30>, '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 0x104c6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d3bbe8>, '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.bBjd9sJJZh/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.jWrsDST7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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:52:21 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:52:21 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:52:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBjd9sJJZh/Render', 03:52:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:21 INFO - 'HOME': '/Users/cltbld', 03:52:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:21 INFO - 'LOGNAME': 'cltbld', 03:52:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:21 INFO - 'MOZ_NO_REMOTE': '1', 03:52:21 INFO - 'NO_EM_RESTART': '1', 03:52:21 INFO - 'PAGER': '/bin/cat', 03:52:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:21 INFO - 'PWD': '/builds/slave/test', 03:52:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:21 INFO - 'SHELL': '/bin/bash', 03:52:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWrsDST7R2/Listeners', 03:52:21 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 03:52:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:21 INFO - 'USER': 'cltbld', 03:52:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:21 INFO - 'XPC_FLAGS': '0x0', 03:52:21 INFO - 'XPC_SERVICE_NAME': '0', 03:52:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:21 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-jBfHvL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:22 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-AKYC_H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:22 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-_0ozmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:22 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-VPGP0F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:22 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-_gkMee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:22 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-oUCx_a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:22 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-GDj0vi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:22 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-5PdV8O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:22 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-Xss5tU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:22 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:22 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-bZRWM2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:23 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-WlY3B0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:23 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-v0IpTL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:23 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-oUlwyw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:23 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-uQ_2A3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:23 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-yrY8LY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:23 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-9npVPA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:23 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-yfzFrp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:23 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:52:23 INFO - Running setup.py install for manifestparser 03:52:23 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:52:23 INFO - Running setup.py install for mozcrash 03:52:24 INFO - Running setup.py install for mozdebug 03:52:24 INFO - Running setup.py install for mozdevice 03:52:24 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:52:24 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:52:24 INFO - Running setup.py install for mozfile 03:52:24 INFO - Running setup.py install for mozhttpd 03:52:24 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:52:24 INFO - Running setup.py install for mozinfo 03:52:24 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:52:24 INFO - Running setup.py install for mozInstall 03:52:24 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:52:24 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:52:24 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:52:24 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:52:24 INFO - Running setup.py install for mozleak 03:52:25 INFO - Running setup.py install for mozlog 03:52:25 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:52:25 INFO - Running setup.py install for moznetwork 03:52:25 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:52:25 INFO - Running setup.py install for mozprocess 03:52:25 INFO - Running setup.py install for mozprofile 03:52:25 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:52:25 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:52:25 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:52:25 INFO - Running setup.py install for mozrunner 03:52:25 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:52:25 INFO - Running setup.py install for mozscreenshot 03:52:26 INFO - Running setup.py install for moztest 03:52:26 INFO - Running setup.py install for mozversion 03:52:26 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:52:26 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:52:26 INFO - Cleaning up... 03:52:26 INFO - Return code: 0 03:52:26 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:52:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:26 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 0x104f68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff492d6adb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d46d30>, '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 0x104c6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d3bbe8>, '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.bBjd9sJJZh/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.jWrsDST7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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:52:26 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:52:26 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:52:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBjd9sJJZh/Render', 03:52:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:26 INFO - 'HOME': '/Users/cltbld', 03:52:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:26 INFO - 'LOGNAME': 'cltbld', 03:52:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:26 INFO - 'MOZ_NO_REMOTE': '1', 03:52:26 INFO - 'NO_EM_RESTART': '1', 03:52:26 INFO - 'PAGER': '/bin/cat', 03:52:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:26 INFO - 'PWD': '/builds/slave/test', 03:52:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:26 INFO - 'SHELL': '/bin/bash', 03:52:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWrsDST7R2/Listeners', 03:52:26 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 03:52:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:26 INFO - 'USER': 'cltbld', 03:52:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:26 INFO - 'XPC_FLAGS': '0x0', 03:52:26 INFO - 'XPC_SERVICE_NAME': '0', 03:52:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:52:26 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-phWnxX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:52:26 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:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:52:26 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-0HdwCN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:52:26 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:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:52:26 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-Huhb6Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:52:26 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:52:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:52:26 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-EPsFmY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:52:27 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-m6FGY1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:52:27 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-v3Bro2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:52:27 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-zWMAYN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:52:27 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-HR8KNC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:52:27 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-j4SBQz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:52:27 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-HgY69V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:52:27 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-jsZLkX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:52:27 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:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:52:27 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-RrvHCB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:52:27 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 03:52:27 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:52:27 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-UTmDpy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:52:28 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:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:52:28 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-1POFZL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:52:28 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:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:28 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-CUcTMv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:52:28 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:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:52:28 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-4nm_qz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:52:28 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:52:28 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:52:28 INFO - Running setup.py (path:/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/pip-opNCuh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:52:28 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:52:28 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:52:28 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:52:28 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:52:28 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:52:28 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:52:28 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:52:28 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:52:28 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:52:28 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:52:28 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:52:28 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:52:28 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:52:31 INFO - Downloading blessings-1.6.tar.gz 03:52:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:52:31 INFO - Installing collected packages: blessings 03:52:31 INFO - Running setup.py install for blessings 03:52:31 INFO - Successfully installed blessings 03:52:31 INFO - Cleaning up... 03:52:31 INFO - Return code: 0 03:52:31 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:52:31 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:31 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:31 INFO - Reading from file tmpfile_stdout 03:52:31 INFO - Current package versions: 03:52:31 INFO - blessings == 1.6 03:52:31 INFO - blobuploader == 1.2.4 03:52:31 INFO - docopt == 0.6.1 03:52:31 INFO - functools32 == 3.2.3-2 03:52:31 INFO - jsonschema == 2.5.1 03:52:31 INFO - manifestparser == 1.1 03:52:31 INFO - mozInstall == 1.12 03:52:31 INFO - mozcrash == 1.0 03:52:31 INFO - mozdebug == 0.1 03:52:31 INFO - mozdevice == 0.49 03:52:31 INFO - mozfile == 1.2 03:52:31 INFO - mozhttpd == 0.7 03:52:31 INFO - mozinfo == 0.9 03:52:31 INFO - mozleak == 0.1 03:52:31 INFO - mozlog == 3.4 03:52:31 INFO - moznetwork == 0.27 03:52:31 INFO - mozprocess == 0.25 03:52:31 INFO - mozprofile == 0.28 03:52:31 INFO - mozrunner == 6.13 03:52:31 INFO - mozscreenshot == 0.1 03:52:31 INFO - mozsystemmonitor == 0.3 03:52:31 INFO - moztest == 0.8 03:52:31 INFO - mozversion == 1.4 03:52:31 INFO - psutil == 3.1.1 03:52:31 INFO - requests == 1.2.3 03:52:31 INFO - wsgiref == 0.1.2 03:52:31 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:52:31 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:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:31 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:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:31 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 0x104f68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff492d6adb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d46d30>, '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 0x104c6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d3bbe8>, '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.bBjd9sJJZh/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.jWrsDST7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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:52:31 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:52:31 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:52:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBjd9sJJZh/Render', 03:52:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:31 INFO - 'HOME': '/Users/cltbld', 03:52:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:31 INFO - 'LOGNAME': 'cltbld', 03:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:31 INFO - 'MOZ_NO_REMOTE': '1', 03:52:31 INFO - 'NO_EM_RESTART': '1', 03:52:31 INFO - 'PAGER': '/bin/cat', 03:52:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:31 INFO - 'PWD': '/builds/slave/test', 03:52:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:31 INFO - 'SHELL': '/bin/bash', 03:52:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWrsDST7R2/Listeners', 03:52:31 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 03:52:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:31 INFO - 'USER': 'cltbld', 03:52:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:31 INFO - 'XPC_FLAGS': '0x0', 03:52:31 INFO - 'XPC_SERVICE_NAME': '0', 03:52:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:31 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:31 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:52:31 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:52:31 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:52:31 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:52:31 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:52:31 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:52:31 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:52:31 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:52:31 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:52:31 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:52:31 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:52:31 INFO - Cleaning up... 03:52:31 INFO - Return code: 0 03:52:31 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:52:31 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:52:31 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:52:31 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:31 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:52:31 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:52:31 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:52:31 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 0x104f68b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104f6b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff492d6adb0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x104d46d30>, '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 0x104c6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d3bbe8>, '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.bBjd9sJJZh/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.jWrsDST7R2/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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:52:31 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:52:31 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:52:31 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBjd9sJJZh/Render', 03:52:31 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:31 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:31 INFO - 'HOME': '/Users/cltbld', 03:52:31 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:31 INFO - 'LOGNAME': 'cltbld', 03:52:31 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:31 INFO - 'MOZ_NO_REMOTE': '1', 03:52:31 INFO - 'NO_EM_RESTART': '1', 03:52:31 INFO - 'PAGER': '/bin/cat', 03:52:31 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:31 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:31 INFO - 'PWD': '/builds/slave/test', 03:52:31 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:31 INFO - 'SHELL': '/bin/bash', 03:52:31 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWrsDST7R2/Listeners', 03:52:31 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 03:52:31 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:31 INFO - 'USER': 'cltbld', 03:52:31 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:31 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:31 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:31 INFO - 'XPC_FLAGS': '0x0', 03:52:31 INFO - 'XPC_SERVICE_NAME': '0', 03:52:31 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:52:32 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:52:32 INFO - Cleaning up... 03:52:32 INFO - Return code: 0 03:52:32 INFO - Running post-action listener: _resource_record_post_action 03:52:32 INFO - Running post-action listener: _start_resource_monitoring 03:52:32 INFO - Starting resource monitoring. 03:52:32 INFO - [mozharness: 2017-03-03 11:52:32.252854Z] Finished create-virtualenv step (success) 03:52:32 INFO - [mozharness: 2017-03-03 11:52:32.253837Z] Running install step. 03:52:32 INFO - Running pre-action listener: _resource_record_pre_action 03:52:32 INFO - Running main action method: install 03:52:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:52:32 INFO - Reading from file tmpfile_stdout 03:52:32 INFO - Detecting whether we're running mozinstall >=1.0... 03:52:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:52:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:52:32 INFO - Reading from file tmpfile_stdout 03:52:32 INFO - Output received: 03:52:32 INFO - Usage: mozinstall [options] installer 03:52:32 INFO - Options: 03:52:32 INFO - -h, --help show this help message and exit 03:52:32 INFO - -d DEST, --destination=DEST 03:52:32 INFO - Directory to install application into. [default: 03:52:32 INFO - "/builds/slave/test"] 03:52:32 INFO - --app=APP Application being installed. [default: firefox] 03:52:32 INFO - mkdir: /builds/slave/test/build/application 03:52:32 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:52:32 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:52:52 INFO - Reading from file tmpfile_stdout 03:52:52 INFO - Output received: 03:52:52 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:52:52 INFO - Running post-action listener: _resource_record_post_action 03:52:52 INFO - [mozharness: 2017-03-03 11:52:52.945078Z] Finished install step (success) 03:52:52 INFO - [mozharness: 2017-03-03 11:52:52.945219Z] Running run-tests step. 03:52:52 INFO - Running pre-action listener: _resource_record_pre_action 03:52:52 INFO - Running main action method: run_tests 03:52:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:52:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:52:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:52:52 INFO - 2017-03-03 03:52:52.959 screenresolution[1937:20934] starting screenresolution argv=screenresolution get 03:52:52 INFO - 2017-03-03 03:52:52.962 screenresolution[1937:20934] Display 0: 1600x1200x32@60 03:52:52 INFO - 2017-03-03 03:52:52.968 screenresolution[1938:20936] starting screenresolution argv=screenresolution list 03:52:52 INFO - Available Modes on Display 0 03:52:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:52:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:52:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:52:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:52:53 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:52:53 INFO - Intel Iris: 03:52:53 INFO - Chipset Model: Intel Iris 03:52:53 INFO - Type: GPU 03:52:53 INFO - Bus: Built-In 03:52:53 INFO - VRAM (Dynamic, Max): 1536 MB 03:52:53 INFO - Vendor: Intel (0x8086) 03:52:53 INFO - Device ID: 0x0a2e 03:52:53 INFO - Revision ID: 0x0009 03:52:53 INFO - Displays: 03:52:53 INFO - Display: 03:52:53 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:52:53 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:52:53 INFO - Display Serial Number: 1600x1200 60 03:52:53 INFO - Main Display: Yes 03:52:53 INFO - Mirror: Off 03:52:53 INFO - Online: Yes 03:52:53 INFO - Rotation: Supported 03:52:53 INFO - Return code: 0 03:52:53 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:52:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:52:53 INFO - Python 2.7.3 03:52:53 INFO - Return code: 0 03:52:53 INFO - grabbing minidump binary from tooltool 03:52:53 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:52:53 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 0x104d46d30>, '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 0x104c6ddb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x104d3bbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:52:53 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:52:53 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:52:53 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:52:53 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:52:53 INFO - Return code: 0 03:52:53 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:52:53 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:52:53 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:52:53 INFO - ENV: RUST_BACKTRACE is now 1 03:52:53 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:52:53 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:52:53 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/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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:52:53 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/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0038 --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:52:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.bBjd9sJJZh/Render', 03:52:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:52:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:52:53 INFO - 'HOME': '/Users/cltbld', 03:52:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:52:53 INFO - 'LOGNAME': 'cltbld', 03:52:53 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:52:53 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:52:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:52:53 INFO - 'MOZ_NO_REMOTE': '1', 03:52:53 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:52:53 INFO - 'NO_EM_RESTART': '1', 03:52:53 INFO - 'PAGER': '/bin/cat', 03:52:53 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:52:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:52:53 INFO - 'PWD': '/builds/slave/test', 03:52:53 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:52:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:52:53 INFO - 'RUST_BACKTRACE': '1', 03:52:53 INFO - 'SHELL': '/bin/bash', 03:52:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.jWrsDST7R2/Listeners', 03:52:53 INFO - 'TMPDIR': '/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/', 03:52:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:52:53 INFO - 'USER': 'cltbld', 03:52:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:52:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:52:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:52:53 INFO - 'XPC_FLAGS': '0x0', 03:52:53 INFO - 'XPC_SERVICE_NAME': '0', 03:52:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:52:53 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/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0038', '--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:52:53 INFO - mozversion application_buildid: 20170303022739 03:52:53 INFO - mozversion application_changeset: 9732cd019a8b94c49a275661320c1b742635a3d6 03:52:53 INFO - mozversion application_display_name: Nightly 03:52:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:52:53 INFO - mozversion application_name: Firefox 03:52:53 INFO - mozversion application_remotingname: firefox 03:52:53 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:52:53 INFO - mozversion application_vendor: Mozilla 03:52:53 INFO - mozversion application_version: 54.0a1 03:52:53 INFO - mozversion platform_buildid: 20170303022739 03:52:53 INFO - mozversion platform_changeset: 9732cd019a8b94c49a275661320c1b742635a3d6 03:52:53 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:52:53 INFO - mozversion platform_version: 54.0a1 03:52:53 INFO - using testdate: 1488541973 03:52:53 INFO - actual date: 1488541973 03:52:53 INFO - starting webserver on 'localhost:56434' 03:52:53 INFO - SUITE-START | Running 2 tests 03:52:53 INFO - TEST-START | dromaeo_css 03:52:53 INFO - operating with platform_type : mac_ 03:52:53 INFO - Initialising browser for dromaeo_css test... 03:52:53 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/tmpm7fgta/profile http://localhost:56434/getInfo.html) 03:52:55 INFO - PROCESS | 1948 | __metrics Screen width/height:1600/1200 03:52:55 INFO - PROCESS | 1948 | colorDepth:24 03:52:55 INFO - PROCESS | 1948 | Browser inner width/height: 1024/689 03:52:55 INFO - PROCESS | 1948 | __metrics 03:52:55 INFO - PROCESS | 1948 | 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:52:55 INFO - PROCESS | 1948 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:52:56 INFO - TEST-INFO | 1948: exit 0 03:52:56 INFO - Browser initialized. 03:52:56 INFO - Running cycle 1/1 for dromaeo_css test... 03:52:56 INFO - TEST-INFO | started process 1950 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/tmpm7fgta/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:53:09 INFO - PROCESS | 1950 | RSS: Main: 233005056 03:53:09 INFO - PROCESS | 1950 | 03:56:12 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:56434/tests/dromaeo/cssquery-dojo.html (next: http://localhost:56434/tests/dromaeo/cssquery-ext.html) 03:56:15 INFO - PROCESS | 1950 | RSS: Main: 370716672 03:56:15 INFO - PROCESS | 1950 | 03:57:58 INFO - PROCESS | 1950 | ************************* 03:57:58 INFO - PROCESS | 1950 | A coding exception was thrown and uncaught in a Task. 03:57:58 INFO - PROCESS | 1950 | 03:57:58 ERROR - PROCESS | 1950 | Full message: TypeError: NetworkError when attempting to fetch resource. 03:57:58 INFO - PROCESS | 1950 | Full stack: 03:57:58 INFO - PROCESS | 1950 | ************************* 03:59:18 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:56434/tests/dromaeo/cssquery-ext.html (next: http://localhost:56434/tests/dromaeo/cssquery-jquery.html) 03:59:18 INFO - PROCESS | 1950 | RSS: Main: 366243840 03:59:18 INFO - PROCESS | 1950 | 04:02:21 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:56434/tests/dromaeo/cssquery-jquery.html (next: http://localhost:56434/tests/dromaeo/cssquery-mootools.html) 04:02:22 INFO - PROCESS | 1950 | RSS: Main: 336863232 04:02:22 INFO - PROCESS | 1950 | 04:05:24 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:56434/tests/dromaeo/cssquery-mootools.html (next: http://localhost:56434/tests/dromaeo/cssquery-prototype.html) 04:05:24 INFO - PROCESS | 1950 | RSS: Main: 333570048 04:05:24 INFO - PROCESS | 1950 | 04:08:28 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:56434/tests/dromaeo/cssquery-prototype.html (next: http://localhost:56434/tests/dromaeo/cssquery-yui.html) 04:08:29 INFO - PROCESS | 1950 | RSS: Main: 333033472 04:08:29 INFO - PROCESS | 1950 | 04:11:32 INFO - PROCESS | 1950 | Cycle 1(1): loaded http://localhost:56434/tests/dromaeo/cssquery-yui.html (next: http://localhost:56434/tests/dromaeo/cssquery-dojo.html) 04:11:33 INFO - PROCESS | 1950 | RSS: Main: 486359040 04:11:33 INFO - PROCESS | 1950 | 04:11:33 INFO - PROCESS | 1950 | __start_tp_report 04:11:33 INFO - PROCESS | 1950 | _x_x_mozilla_page_load 04:11:33 INFO - PROCESS | 1950 | _x_x_mozilla_page_load_details 04:11:33 INFO - PROCESS | 1950 | |i|pagename|runs| 04:11:33 INFO - PROCESS | 1950 | |0;dojo.html;2662.4142688608504;3314.685104915033;3335.4830001349783;3353.161709572607;3389.2204792897633;5621.156826476031;5708.657480551165;5716;5781.161731548928;5816.767329306833;5693.544516438686;5730.36965933747;5784.045632470647;5796.8260952171395;5808.970955145219;4315.331123675835;5190.92213616796;5194.610404219679;5261.579073674096;5274.129768588178;5357;5365.731713414333;5370.570354371641;5391.892162156754;5423;5160.019596276733;5207.895842083175;5221.477852214748;5259.710715910604;5327.440618735016;5229.764660590283;5235.267062611238;5284.682919024833;5288.259643649853;5340.225667278261;5212.556932660728;5234.450382709799;5243.659162154486;5246.737663116829;5272.833874926707;5576.33084029915;5773.595848290579;5774.2782152230975;5791.710414479301;5816.069428891357;5105.770240339194;6137.438273608336;6193.535484838655;6206.565540412173;6211.565190436671;6111.478540206961;6252.3747625237565;6266.655333956631;6268.373162683741;6290.119383286344;5906.291245050578;5911.142884281755;5972.5520585955355;5973.551983601204;5984.670843103628;6357.364263573606;6366.586171898812;6372.203474565679;6374.681265936684;6379.74481020754;6031.668258245751;6077.787277445268;6083.847903802441;6238.469730072904;6241.126242326078;6193.102000209944;6196.752129914753;6198.566100373021;6199.3490683477585;6212.751489940442;6184.8763024739255;6199.876002480015;6240.00159974402;6245.594036387621;6291.591046581958;6272.498200143978;6280.748770049238;6282.308946015934;6288.811335659938;6297.118403423525;5076.44159142494;5079.568236699848;5086.287919691246;5091.719955402488;5108.106081435808;4384.69307148503;4411.779411029435;4424.048829501673;4433.733975961452;4533.320001999727;5791.362950075489;5796.768129274866;5809.390014048548;5843.2695913010875;5867.765289388462;6280.717367718464;6281.528885333618;6284.12022316876;6298.275698294663;6310.558260921784;5620.831375058755;5687.090065589568;5812.244408226903;5832.212651292106;5852.268466441695;5468.398476167618;5508.9724551376985;5514.228008078872;5546.389897111315;5598.440155984369;6412.396900774899;6425.935740642627;6427.035944608346;6432.614043157426;6449.6130232186215;6252.343503932022;6280.152179455715;6296.370362963667;6319.399657032574;6323.114763932961;6200.131981522501;6216.098665693358;6234.844128896814;6237.5009999200865;6280.717367718372;6176.413240742122;6178;6180.66006369636;6183.3816618337805;6194.473469755121;6149.754009839735;6232.688365581794;6260.937390626035;6298.622082674871;6336.7148478319505;6122.938770612415;6208.192934918432;6217.067439884054;6217.347178546188;6226.1905952225925;5969.8806023878415;6197.876042479035;6224.502039836892;6224.502039836892;6228.968855155696;5877.529797616266;5939.406059394026;5939.554533410098;5947.553933455095;5953.583249172516;6129.389354848411;6137.101203255209;6141.117811339906;6223.906641400292;6230.719617617127;5991.831592839355;6020.096985452217;6023.36754640774;6024.909626355696;6063.787767428119 04:11:33 INFO - PROCESS | 1950 | |1;ext.html;641.9069234960931;847.8219573889482;869.7782065573277;871.9825603487934;873.0789017586444;28167.718322816792;28398.14805555834;28452.57321140182;29471.115866523985;39999;39441.60558394423;42293.15413691724;42295;42302;42345.576544234624;9255.953720231406;9426.905730942672;9428.575714092882;9428.952855235748;9467.24262059037;7475.476716629811;7635.442126887499;9222.400543964653;9343.532823358839;9352.953235233814;7614.543127412373;7646.311831935125;7654.043244594426;11074.280171788849;11305.321680699184;9327.39371940825;11284.661460156127;11288.153388495895;11301.321920684784;11302.830457543185;9367.672131475434;10903.236773425864;10910.727231819268;10977.39624320662;10984.835227471594;27555.586666200023;27822.721772782217;27854.860725696446;38821.41767873484;39109;3065.5401689746495;3737.588865224823;3760.3795373763296;3831.942520862189;3958.960410395888;27388.863055684793;27989.300267493272;28064.438711225866;28455.430891382057;28515.42969140626;2440.865752383618;2825.971740282612;2840.3041254892682;2858.085412667947;2955;326728;334330;334524;335433;336794.31602842076;50918.23622645663;51536;51559.711007225116;51638.22542661863;51649.96700065977;43157.784211078746;43862.78068609637;52805.7359713199;53740.462595373545;54004;11656.53373865036;13696.246706431242;13795.655108622364;13809.861901381058;13810.240436776074;9720.368176068532;11674.241174323643;11795.882041179479;11799.76400472003;12001.519939202333;12335.198212116184;12339.197952133083;12351.073669474825;12371.628851134481;12400.503979840885;5444.891102177934;5465.945340546623;5470.753816078286;5472.945270547323;5490.203920431515;1006.642641862143;1045.1220974381556;1089.84742136101;1122.71370800447;1174.8531433570804;25362;25429.491410171693;25559.23322300334;25883.482330353287;26528.60207096895;1033.7674023344687;1239.330761388858;1254.4668515880714;1261.8801213884667;1267.524678245658;12744.36278186087;13336.399862006234;13452.394642240926;13591.320433978262;13625.454981800616;394781;396152;397694;397718;397833;54722;54761.61907047427;54825.45174548204;54837;54909;1366.4602482019548;1441.4378392426752;1443.7329094117622;1443.9711205776036;1454.0621299262127;24151.316183367257;25127.3667211638;25140.62289065629;25204.495910082063;25252;36592;46194.307085394415;46256.53743462657;46342.30486542772;46350.30474542952;372288;372660;372899;520593;534607;28572.999945001826;36342.63657363393;36721.63278367182;37183.211259155134;37394.813025934694;43763.562364375946;44836.551634483236;44896.87757806081;45872;46911.765441172574;32330.030099097065;37211.441828373136;38610.841674749805;38704.41943370795;39791;37241.068973275884;37283.627163728015;37678;39133;39220.038998049415;38621.6137838618;38863.41704874373;38956.41565376465;39839;40109.79945100256;31067.912623058084;33933.402291533974;34305.48541771826;34578;34694.47958280678;25366.619500707875;25559.361015974748;25738.485230295664;25817.612735809354;25944.72197117906 04:11:33 INFO - PROCESS | 1950 | |2;jquery.html;380.8838304317182;395.8772780438064;396.7520299812617;411.16738604326235;440.60125586344367;12380.400969549466;19898.900505497488;20820.99999999998;21621.3513594592;21741.78258217417;17848.464546063606;21218.89390553049;21588;22273;22404.32787016388;6490.2860685324695;6691.6319602421845;6715.059891615178;6771;6781.220159681626;6389.904151437732;6542.705578248991;6567.901481477782;6568.7372505099975;6648.601083934956;6569;6576.6711664416825;7037.788866333993;7363.631818409085;7459.030326057605;7273.272672732684;7274.672639731225;7299.02926209923;7361.5583065015735;7363.889541656907;6989.44084473246;7174.246704096047;7176.461765367566;7181.245969173214;7197.028401165828;24897.751022489723;25036.624450633255;25650.87174564134;25877.223683289532;26097.608535871976;2823.336515918778;2834.4897918374686;2847.145856243119;2848.7863410244313;2854.743073123408;14463.49377771773;14661.853381466262;15021.948463607552;15419.103023810574;16110.952788068738;1861.9813801861944;1862.608852141052;1876.5121068522146;1879.1074239736154;1885.9528511787178;140742.29628851893;150348.9581250246;151705.72441413387;158813.82372352603;161970;14716.852831471548;18834.623307533773;18917.14872830726;19238.941858197933;19425.222991080198;33053.834730826195;39222.21555568872;41859.7907010463;42054.789726051786;42203.36694949578;8722.193636695123;10865.619703310345;11167.38579378142;11171.218014739054;11192.720181995352;8525.488470691778;8566.258797184966;8777.91222087771;8902.46279810251;9086.136817002507;9493;10080.69757907264;10120.898791012143;10778.407187604756;10931.125509959184;3905.2970465316516;4050.8987275318354;4052.979735101306;4053.3312003519677;4069.409935559327;934.3412893909913;965.3821554205314;985.1675334342469;1013.8428543575758;1030.7526193713454;19854.90072549657;20607;20632.17471301131;20690.068946897427;20909.28469802049;876.8158686675743;934.5514153206499;953.8378475659155;966.7776411425411;991.4101109839634;10195.28632995698;10646.562255363924;10705.9464702676;10731;10780.78438431227;653968;681397;691736;709033;715023;106359;146809;151730;153834.38573335516;154771;1018.1447584029303;1058.1376178414569;1105.7788442311569;1107.5293000474767;1107.9944600277108;17637.765356424927;19107.617847643247;19382.8061719381;19647.214111435384;19709.211631534577;39580;51759.2236116451;56275.87448251094;57781.13328300163;57899;73992.63003684947;79858.60070699609;81444;82437.58781206056;82581.76127357974;7303.598302093435;9462.243020558477;9599.904000960181;9914.702558923243;10232.209363361531;12552.184108032949;12690.87309126897;12697.492100315883;12952.222866628032;12964.351782410653;10666.46667666629;10706.73233169177;10868.402237876993;11038.116950643769;11052;8433.367497437594;9689.951550242204;10190.235732319958;10212.387256764618;10212.897871021492;10906.50920708554;11120.721981950515;11146.777064458827;11153.386563739072;11209.663710088711;9692.903070969482;9847.113759761656;9972.700818975442;10005.599776008878;10011.299209055296;9658.275629327969;10339;10635.308704934154;10875.184361172785;10983.450827458755 04:11:33 INFO - PROCESS | 1950 | |3;mootools.html;1548.3651702801853;1553.8989965652224;1573.2762929052635;1589.3324803582493;1592.3948899418222;10345.793084138313;10955.890441095597;10958.835617465744;10969.780604387908;10988.945055274722;10544.841827372577;10658.946705266482;10901.672949811518;10931.781364372708;11076.889231107687;2334.5914464968646;2357.3870793593705;2369.9289021329387;2374.489484760776;2379.2267513058237;2338.1465764995737;2367.585672507313;2373.620220764678;2373.750756170603;2376.7266764322067;2306.9538609227807;2307.769223077687;2331.1957374705785;2332.043862016565;2339.801116905065;2289.553537060274;2293.8738369389675;2313.6580783145737;2320.1995311617466;2320.5938960681815;2261.344210179046;2328.406256404623;2332.3702600297993;2332.6384410416244;2334.2063698342645;10942.945285273603;11047.83428248577;11058.944705276503;11060.391678457681;11068.612598559092;5392.568594512469;5618;5782.3639399666;5814.883702325972;5817.970910145422;3345.1637090727318;3503.8248087595516;3547.5565554305713;3583.605803361628;3586.22896077342;1066.7759770448215;1088.450332582049;1135.403912945702;1141.5148561861176;1150.177622999551;13638.93180534091;14006.369713362923;14019.649508762159;15004.624884377869;15038.774418383733;4205.137946720914;4316.611504964569;4328.11273688893;4328.978355108205;4351.151525452507;9457.574409151604;11174.553017879194;11521;11628;11631.6510504685;5522.6134170607675;5556.833295001075;5588.720563971785;5591.077472217039;5595.7481913313995;4897.706137631753;5188.092083885305;5254.527092561688;5255.13290307095;5261.736913154327;3633.255182687543;3766.4350347448103;3802.239552089593;3840.8271627776817;3863.5363756349416;986.1913231150388;987.8468837330225;996.2776986684596;1003.8895721470633;1008.8789345278614;878.7407714724171;914.07221670005;915.9084091590921;941.3222479814523;941.6892425499568;6105.572609917352;6258.9359808832605;6290.77329920661;6343.9682801585695;6510.446612037935;849.3884403229665;952.5189779161618;963.6723514005132;1002.0830939690247;1005.0853723111933;3279.7212236960127;3909.9609003909595;4053.6554392876938;4147.688923330762;4165.97917010413;12586;13235.27206003679;13315.533956311676;13449.058565900488;13463.798043029363;13049.217046977212;13132.737345253041;13334.733305333839;13365.599032029055;13379.929605631527;9833.311668183302;9953.950230248947;9964.950175249078;10061.748456288651;10073.748156296151;6331.27190373113;6353.745850165941;6412.839679008062;6482.118808918263;6487.253965793805;9549.28380371461;11777.293362398283;11917.22538035025;11956.10329225329;12002.339871307162;11991.160618756603;12024.33866137371;12220.144589878622;12250.754984900073;12380.133390662568;8154.0215174179475;8320.417570769989;8323.583820808813;8327.50034997902;8329.375296852639;9865.901340986498;9872.950635247065;9904.306698531034;9981.101700846959;10028.29801913859;8674.566271686517;8715.30277577805;8780.736577902673;8955.776105597151;8973.641054357753;8508.361872859436;8551.74344769658;8635.870461943201;8710.47737135774;8711.303095752452;7416.369608583331;7491.175970643334;7512.474126811071;7587.165411804586;7609.695612175451;5665.773369065356;5802.506786923159;5816.82549523515;5889.852753681193;5916.437938395846;5107.2594473800345;5509.311336082989;5921.61509501881;5941.168236446987;5967.254093238345 04:11:33 INFO - PROCESS | 1950 | |4;prototype.html;341.6419731567021;350.74395691145463;372.12550506310157;375.66941091839175;377.09873402567865;4268.423762792026;4447.642749342854;5296.496832800887;5301.045811753887;5304.6286759926825;5071.898562028758;5222.92165617516;5276.393214780302;5287.47125287471;5296.470352964701;4157.625813676768;4174.373843923406;4348.695591308609;4401.66987475939;4446.822127114928;4388.188185185751;4395.362672412498;4395.626371758404;4413.9185899454515;4414.13924284763;3658.762180458275;4384.89037774055;4413.58070983256;4431.43854462649;4476.932846007313;4001.8399264029404;4057.6753859691153;4195.601417865298;4250.404943307939;4426.9154057255855;4025.3156963316305;4040.5555388907196;4061.6344528992236;4074.5517993020744;4095.508538975342;4787.736674482902;4788.545088216614;5072.239164125411;5136.0241554104605;5178.300929374562;4185.686073544496;4622.6070783983405;4857.441394239637;5034.370703662043;5079.875876336064;4630.699004564726;5070.442251352349;5292.761825717852;5389.948959952811;5611.326640803089;4460.776961151962;4485.9102817943785;4505.774711264424;4518.43519560055;4537.5706652404715;4314.848980285707;5373.274607927919;5871.941280587225;5909.852253693692;5991.64050156992;3798.5061941947924;4514.367988481616;4519.322101684708;4526.6152377047665;4573.131105090022;3910.9608903911167;4144.585541445831;4458.754768487699;4632.795473176998;4634.235351167087;3864.3962755456173;4124.91750164995;4879.243472349951;4963.337282010567;5031.471695471996;5173.974130129401;5538.16927460876;5600.439956004367;5665.49010589049;5679.545636349165;1310.377570653951;1381.8134551835574;1413.2792275939346;1503.7067771784616;1521.5359315408907;1075.4300220882944;1099.4612639806437;1135.40391294571;1143.416857402714;1152.5850693750244;4515.419603138875;4705.364775755298;4905.583025442877;4946.554810067039;4970.428400733889;5078.923816142761;5315.847081931824;5385.78456861729;5411.972940135274;5487.765252818084;4518.012074687127;4543.6365090793315;4735.408073990751;4953.50464953509;5338.9322135572265;2582.7804636606097;2722.986385068062;2819.224713203844;2847.8291302521916;2850.686424493304;4798.23228283473;4799.833049285226;5492.517020404468;5642.85892852682;5737.328110009597;4653.277832467977;4711.963368059021;4975.019984012775;5466.426025267289;5550.973069981986;4733.337332773414;5208.0469823816065;5358.4373640767935;5659.236003139606;5766.740496677576;4617.215073437591;4809.807607695653;5391.083515802401;5484.369297530835;5505.779768809202;4732.479427263067;4783.856484305476;4850.871188083737;5403.02745505797;5489.780408783604;5521.631804599111;5732.226149469769;5741.421109194837;5744.834994628861;5756.366799651951;3612.8554857806444;3868.8259028343227;4254.234237837219;4344.5221025686515;4375.212461756914;4580.228961478258;5274.578033757367;5419.593530485151;5725.112607545837;5809.896119737236;4504.369388285577;4856.514348565256;5559.221708960829;5593.244911936837;5600.411956744646;4666.250156191428;5029.717422057498;5558.666480011212;5568.415316391883;5589.55283577321;5073.315102461268;5106.770195341144;5167.22491626244;5474.742528195718;5495.499547705865;4951.702897825998;5352.518273355417;5509.283793106871;5583.6878333592385;5631.267935168566;4154.273002224538;4672.836450724209;4689.296605509201;5108.463611320906;5449.782008719607 04:11:33 INFO - PROCESS | 1950 | |5;yui.html;575.3469811763647;732.1653315220649;748.2330611123598;777.9533228006317;839.5634270179506;14406.423743050278;15190.468333608325;15206.163660998669;15217.771733423993;15226.923865380671;13492.190468571893;13687.863121368784;13693.726125477484;13803.65490862729;13835.377408016639;894.3962825093068;958.314804914486;976.0971101730906;977.4575110813496;977.7066879936026;784.6155383861924;959.0744931141447;961.0677642686618;964.5852283518119;967.4002118686424;976.8827740671129;1011.5397494140149;1011.6914341125954;1011.8482227665835;1014.5688082564917;1000.7348052765986;1000.9999999999964;1001.0540039662521;1001.1090129784498;1004.437514991607;751.0086685575043;753.3521171792254;753.7437271327775;755.7770457714932;755.928186822251;13891.652708682263;14888.776668349983;15422.997505162128;15521.991070580376;15528.301226444837;13774.380152893043;13788.448462061506;13800.95312090178;13886.180479554192;14006.509772158028;11350.71623209418;11467.139964502696;11631.941840290829;11649.534018639244;11976.940115299454;3596.9477442324455;3640.2537479816574;3679.2089700714473;3679.2457546202963;3686.5207523022104;98588;99116.50441747745;100244;100274;101025.98974010239;10114.494275286206;10242;10535.157187424988;10614.257002009785;10701.09040731531;21710.565788684136;22033.245844269466;22036.669449958263;22078.558428831653;22091.558168836535;7056.647167641598;7097.858042839114;7178.17450993132;7318.194998550155;7362.116546014512;4061.6750659947133;4122.9381559276635;4137.689673274516;4206.179794940019;4212.010177608259;3041.285297954979;3106.891258805931;3121.984390078035;3123.6720144384512;3130.7964982276535;537.4437457231746;612.5895649914568;620.1442010026225;624.2290770897937;635.6948664640905;643.9903401448983;660.6102399584269;663.867226554691;673.7675501951819;683.7265093962454;8825.514596697114;9210.309226808016;9517.384743001663;9808.324287349991;9927.255455840841;651.9178164247327;658.6838317607575;683.5628363406109;696.7631005458169;703.6165289917008;3839;4343.609075183249;4666.743329116864;4672.556107169813;4737.8341758038305;71968.2803171972;74065.25934740584;77407.22592774;80413.59793200997;101351.47972780414;47765.31000380346;58776.41223587709;60738.696306518184;76702.46595068068;80210;59937.400625993185;60092;62212;63868.36131638624;64248;8752.64989400417;9296.205660857073;9384.76538086526;9422.246220302497;9537.809243814945;39515.604843951194;42496;44477.33284000678;47481.52518474771;47840.521594783604;65511.672441637485;67787;68647.31352686409;69795.6510217466;70448.64775676088;12298.049655076566;12593.559225427067;12612;12627.558035468715;12798.424070917017;12036.819447708467;12356.814647780111;14051.36768845384;14491.637709057359;14546.141870147232;10815.405152716676;13380.264085475392;13485;13995.930020349833;14019.088759230617;13165.275909824668;13286.867131328563;13296.401661925043;13470.865291346961;13851;10602.681919542118;12682.302473364054;12852.614421567368;13069.215847048827;13732.45070197221;10653.820783945448;10865.565377384815;10929.07102896231;10939.507722152362;11413.144014198802;8955.729971776558;9175.770605734642;10452.41268598646;10675.839862401916;10847.837282440927 04:11:33 INFO - PROCESS | 1950 | __end_tp_report 04:11:33 INFO - PROCESS | 1950 | __start_cc_report 04:11:33 INFO - PROCESS | 1950 | _x_x_mozilla_cycle_collect,2666 04:11:33 INFO - PROCESS | 1950 | __end_cc_report 04:11:33 INFO - PROCESS | 1950 | __startTimestamp1488543093103__endTimestamp 04:11:33 INFO - PROCESS | 1950 | 04:11:33 INFO - PROCESS | 1950 | ------- Summary: start ------- 04:11:33 INFO - PROCESS | 1950 | Number of tests: 6 04:11:33 INFO - PROCESS | 1950 | 04:11:33 INFO - PROCESS | 1950 | [#0] dojo.html Cycles:165 Average:5782.72 Median:5991.83 stddev:663.57 (11.1%) stddev-sans-first:618.82 04:11:33 INFO - PROCESS | 1950 | Values: 2662.4 3314.7 3335.5 3353.2 3389.2 5621.2 5708.7 5716.0 5781.2 5816.8 5693.5 5730.4 5784.0 5796.8 5809.0 4315.3 5190.9 5194.6 5261.6 5274.1 5357.0 5365.7 5370.6 5391.9 5423.0 5160.0 5207.9 5221.5 5259.7 5327.4 5229.8 5235.3 5284.7 5288.3 5340.2 5212.6 5234.5 5243.7 5246.7 5272.8 5576.3 5773.6 5774.3 5791.7 5816.1 5105.8 6137.4 6193.5 6206.6 6211.6 6111.5 6252.4 6266.7 6268.4 6290.1 5906.3 5911.1 5972.6 5973.6 5984.7 6357.4 6366.6 6372.2 6374.7 6379.7 6031.7 6077.8 6083.8 6238.5 6241.1 6193.1 6196.8 6198.6 6199.3 6212.8 6184.9 6199.9 6240.0 6245.6 6291.6 6272.5 6280.7 6282.3 6288.8 6297.1 5076.4 5079.6 5086.3 5091.7 5108.1 4384.7 4411.8 4424.0 4433.7 4533.3 5791.4 5796.8 5809.4 5843.3 5867.8 6280.7 6281.5 6284.1 6298.3 6310.6 5620.8 5687.1 5812.2 5832.2 5852.3 5468.4 5509.0 5514.2 5546.4 5598.4 6412.4 6425.9 6427.0 6432.6 6449.6 6252.3 6280.2 6296.4 6319.4 6323.1 6200.1 6216.1 6234.8 6237.5 6280.7 6176.4 6178.0 6180.7 6183.4 6194.5 6149.8 6232.7 6260.9 6298.6 6336.7 6122.9 6208.2 6217.1 6217.3 6226.2 5969.9 6197.9 6224.5 6224.5 6229.0 5877.5 5939.4 5939.6 5947.6 5953.6 6129.4 6137.1 6141.1 6223.9 6230.7 5991.8 6020.1 6023.4 6024.9 6063.8 04:11:33 INFO - PROCESS | 1950 | 04:11:33 INFO - PROCESS | 1950 | [#1] ext.html Cycles:180 Average:53304.63 Median:36656.82 stddev:104076.99 (283.9%) stddev-sans-first:104293.84 04:11:33 INFO - PROCESS | 1950 | Values: 641.9 847.8 869.8 872.0 873.1 28167.7 28398.1 28452.6 29471.1 39999.0 39441.6 42293.2 42295.0 42302.0 42345.6 9256.0 9426.9 9428.6 9429.0 9467.2 7475.5 7635.4 9222.4 9343.5 9353.0 7614.5 7646.3 7654.0 11074.3 11305.3 9327.4 11284.7 11288.2 11301.3 11302.8 9367.7 10903.2 10910.7 10977.4 10984.8 27555.6 27822.7 27854.9 38821.4 39109.0 3065.5 3737.6 3760.4 3831.9 3959.0 27388.9 27989.3 28064.4 28455.4 28515.4 2440.9 2826.0 2840.3 2858.1 2955.0 326728.0 334330.0 334524.0 335433.0 336794.3 50918.2 51536.0 51559.7 51638.2 51650.0 43157.8 43862.8 52805.7 53740.5 54004.0 11656.5 13696.2 13795.7 13809.9 13810.2 9720.4 11674.2 11795.9 11799.8 12001.5 12335.2 12339.2 12351.1 12371.6 12400.5 5444.9 5465.9 5470.8 5472.9 5490.2 1006.6 1045.1 1089.8 1122.7 1174.9 25362.0 25429.5 25559.2 25883.5 26528.6 1033.8 1239.3 1254.5 1261.9 1267.5 12744.4 13336.4 13452.4 13591.3 13625.5 394781.0 396152.0 397694.0 397718.0 397833.0 54722.0 54761.6 54825.5 54837.0 54909.0 1366.5 1441.4 1443.7 1444.0 1454.1 24151.3 25127.4 25140.6 25204.5 25252.0 36592.0 46194.3 46256.5 46342.3 46350.3 372288.0 372660.0 372899.0 520593.0 534607.0 28573.0 36342.6 36721.6 37183.2 37394.8 43763.6 44836.6 44896.9 45872.0 46911.8 32330.0 37211.4 38610.8 38704.4 39791.0 37241.1 37283.6 37678.0 39133.0 39220.0 38621.6 38863.4 38956.4 39839.0 40109.8 31067.9 33933.4 34305.5 34578.0 34694.5 25366.6 25559.4 25738.5 25817.6 25944.7 04:11:33 INFO - PROCESS | 1950 | 04:11:33 INFO - PROCESS | 1950 | [#2] jquery.html Cycles:180 Average:40507.08 Median:24967.19 stddev:115434.59 (462.3%) stddev-sans-first:115719.10 04:11:33 INFO - PROCESS | 1950 | Values: 380.9 395.9 396.8 411.2 440.6 12380.4 19898.9 20821.0 21621.4 21741.8 17848.5 21218.9 21588.0 22273.0 22404.3 6490.3 6691.6 6715.1 6771.0 6781.2 6389.9 6542.7 6567.9 6568.7 6648.6 6569.0 6576.7 7037.8 7363.6 7459.0 7273.3 7274.7 7299.0 7361.6 7363.9 6989.4 7174.2 7176.5 7181.2 7197.0 24897.8 25036.6 25650.9 25877.2 26097.6 2823.3 2834.5 2847.1 2848.8 2854.7 14463.5 14661.9 15021.9 15419.1 16111.0 1862.0 1862.6 1876.5 1879.1 1886.0 140742.3 150349.0 151705.7 158813.8 161970.0 14716.9 18834.6 18917.1 19238.9 19425.2 33053.8 39222.2 41859.8 42054.8 42203.4 8722.2 10865.6 11167.4 11171.2 11192.7 8525.5 8566.3 8777.9 8902.5 9086.1 9493.0 10080.7 10120.9 10778.4 10931.1 3905.3 4050.9 4053.0 4053.3 4069.4 934.3 965.4 985.2 1013.8 1030.8 19854.9 20607.0 20632.2 20690.1 20909.3 876.8 934.6 953.8 966.8 991.4 10195.3 10646.6 10705.9 10731.0 10780.8 653968.0 681397.0 691736.0 709033.0 715023.0 106359.0 146809.0 151730.0 153834.4 154771.0 1018.1 1058.1 1105.8 1107.5 1108.0 17637.8 19107.6 19382.8 19647.2 19709.2 39580.0 51759.2 56275.9 57781.1 57899.0 73992.6 79858.6 81444.0 82437.6 82581.8 7303.6 9462.2 9599.9 9914.7 10232.2 12552.2 12690.9 12697.5 12952.2 12964.4 10666.5 10706.7 10868.4 11038.1 11052.0 8433.4 9690.0 10190.2 10212.4 10212.9 10906.5 11120.7 11146.8 11153.4 11209.7 9692.9 9847.1 9972.7 10005.6 10011.3 9658.3 10339.0 10635.3 10875.2 10983.5 04:11:33 INFO - PROCESS | 1950 | 04:11:33 INFO - PROCESS | 1950 | [#3] mootools.html Cycles:180 Average:6521.30 Median:3609.74 stddev:4069.30 (112.7%) stddev-sans-first:4063.56 04:11:33 INFO - PROCESS | 1950 | Values: 1548.4 1553.9 1573.3 1589.3 1592.4 10345.8 10955.9 10958.8 10969.8 10988.9 10544.8 10658.9 10901.7 10931.8 11076.9 2334.6 2357.4 2369.9 2374.5 2379.2 2338.1 2367.6 2373.6 2373.8 2376.7 2307.0 2307.8 2331.2 2332.0 2339.8 2289.6 2293.9 2313.7 2320.2 2320.6 2261.3 2328.4 2332.4 2332.6 2334.2 10942.9 11047.8 11058.9 11060.4 11068.6 5392.6 5618.0 5782.4 5814.9 5818.0 3345.2 3503.8 3547.6 3583.6 3586.2 1066.8 1088.5 1135.4 1141.5 1150.2 13638.9 14006.4 14019.6 15004.6 15038.8 4205.1 4316.6 4328.1 4329.0 4351.2 9457.6 11174.6 11521.0 11628.0 11631.7 5522.6 5556.8 5588.7 5591.1 5595.7 4897.7 5188.1 5254.5 5255.1 5261.7 3633.3 3766.4 3802.2 3840.8 3863.5 986.2 987.8 996.3 1003.9 1008.9 878.7 914.1 915.9 941.3 941.7 6105.6 6258.9 6290.8 6344.0 6510.4 849.4 952.5 963.7 1002.1 1005.1 3279.7 3910.0 4053.7 4147.7 4166.0 12586.0 13235.3 13315.5 13449.1 13463.8 13049.2 13132.7 13334.7 13365.6 13379.9 9833.3 9954.0 9965.0 10061.7 10073.7 6331.3 6353.7 6412.8 6482.1 6487.3 9549.3 11777.3 11917.2 11956.1 12002.3 11991.2 12024.3 12220.1 12250.8 12380.1 8154.0 8320.4 8323.6 8327.5 8329.4 9865.9 9873.0 9904.3 9981.1 10028.3 8674.6 8715.3 8780.7 8955.8 8973.6 8508.4 8551.7 8635.9 8710.5 8711.3 7416.4 7491.2 7512.5 7587.2 7609.7 5665.8 5802.5 5816.8 5889.9 5916.4 5107.3 5509.3 5921.6 5941.2 5967.3 04:11:33 INFO - PROCESS | 1950 | 04:11:33 INFO - PROCESS | 1950 | [#4] prototype.html Cycles:180 Average:4524.28 Median:4788.14 stddev:1255.75 (26.2%) stddev-sans-first:1219.40 04:11:33 INFO - PROCESS | 1950 | Values: 341.6 350.7 372.1 375.7 377.1 4268.4 4447.6 5296.5 5301.0 5304.6 5071.9 5222.9 5276.4 5287.5 5296.5 4157.6 4174.4 4348.7 4401.7 4446.8 4388.2 4395.4 4395.6 4413.9 4414.1 3658.8 4384.9 4413.6 4431.4 4476.9 4001.8 4057.7 4195.6 4250.4 4426.9 4025.3 4040.6 4061.6 4074.6 4095.5 4787.7 4788.5 5072.2 5136.0 5178.3 4185.7 4622.6 4857.4 5034.4 5079.9 4630.7 5070.4 5292.8 5389.9 5611.3 4460.8 4485.9 4505.8 4518.4 4537.6 4314.8 5373.3 5871.9 5909.9 5991.6 3798.5 4514.4 4519.3 4526.6 4573.1 3911.0 4144.6 4458.8 4632.8 4634.2 3864.4 4124.9 4879.2 4963.3 5031.5 5174.0 5538.2 5600.4 5665.5 5679.5 1310.4 1381.8 1413.3 1503.7 1521.5 1075.4 1099.5 1135.4 1143.4 1152.6 4515.4 4705.4 4905.6 4946.6 4970.4 5078.9 5315.8 5385.8 5412.0 5487.8 4518.0 4543.6 4735.4 4953.5 5338.9 2582.8 2723.0 2819.2 2847.8 2850.7 4798.2 4799.8 5492.5 5642.9 5737.3 4653.3 4712.0 4975.0 5466.4 5551.0 4733.3 5208.0 5358.4 5659.2 5766.7 4617.2 4809.8 5391.1 5484.4 5505.8 4732.5 4783.9 4850.9 5403.0 5489.8 5521.6 5732.2 5741.4 5744.8 5756.4 3612.9 3868.8 4254.2 4344.5 4375.2 4580.2 5274.6 5419.6 5725.1 5809.9 4504.4 4856.5 5559.2 5593.2 5600.4 4666.3 5029.7 5558.7 5568.4 5589.6 5073.3 5106.8 5167.2 5474.7 5495.5 4951.7 5352.5 5509.3 5583.7 5631.3 4154.3 4672.8 4689.3 5108.5 5449.8 04:11:33 INFO - PROCESS | 1950 | 04:11:33 INFO - PROCESS | 1950 | [#5] yui.html Cycles:180 Average:18253.83 Median:3762.76 stddev:25044.70 (665.6%) stddev-sans-first:25079.78 04:11:33 INFO - PROCESS | 1950 | Values: 575.3 732.2 748.2 778.0 839.6 14406.4 15190.5 15206.2 15217.8 15226.9 13492.2 13687.9 13693.7 13803.7 13835.4 894.4 958.3 976.1 977.5 977.7 784.6 959.1 961.1 964.6 967.4 976.9 1011.5 1011.7 1011.8 1014.6 1000.7 1001.0 1001.1 1001.1 1004.4 751.0 753.4 753.7 755.8 755.9 13891.7 14888.8 15423.0 15522.0 15528.3 13774.4 13788.4 13801.0 13886.2 14006.5 11350.7 11467.1 11631.9 11649.5 11976.9 3596.9 3640.3 3679.2 3679.2 3686.5 98588.0 99116.5 100244.0 100274.0 101026.0 10114.5 10242.0 10535.2 10614.3 10701.1 21710.6 22033.2 22036.7 22078.6 22091.6 7056.6 7097.9 7178.2 7318.2 7362.1 4061.7 4122.9 4137.7 4206.2 4212.0 3041.3 3106.9 3122.0 3123.7 3130.8 537.4 612.6 620.1 624.2 635.7 644.0 660.6 663.9 673.8 683.7 8825.5 9210.3 9517.4 9808.3 9927.3 651.9 658.7 683.6 696.8 703.6 3839.0 4343.6 4666.7 4672.6 4737.8 71968.3 74065.3 77407.2 80413.6 101351.5 47765.3 58776.4 60738.7 76702.5 80210.0 59937.4 60092.0 62212.0 63868.4 64248.0 8752.6 9296.2 9384.8 9422.2 9537.8 39515.6 42496.0 44477.3 47481.5 47840.5 65511.7 67787.0 68647.3 69795.7 70448.6 12298.0 12593.6 12612.0 12627.6 12798.4 12036.8 12356.8 14051.4 14491.6 14546.1 10815.4 13380.3 13485.0 13995.9 14019.1 13165.3 13286.9 13296.4 13470.9 13851.0 10602.7 12682.3 12852.6 13069.2 13732.5 10653.8 10865.6 10929.1 10939.5 11413.1 8955.7 9175.8 10452.4 10675.8 10847.8 04:11:33 INFO - PROCESS | 1950 | -------- Summary: end -------- 04:11:33 INFO - PROCESS | 1950 | 04:11:33 INFO - TEST-INFO | 1950: exit 0 04:11:33 INFO - TEST-OK | dromaeo_css | took 1120241ms 04:11:33 INFO - TEST-START | kraken 04:11:33 INFO - operating with platform_type : mac_ 04:11:33 INFO - Initialising browser for kraken test... 04:11:33 INFO - TEST-INFO | started process 1955 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/tmp3ba23I/profile http://localhost:56434/getInfo.html) 04:11:36 INFO - PROCESS | 1955 | __metrics Screen width/height:1600/1200 04:11:36 INFO - PROCESS | 1955 | colorDepth:24 04:11:36 INFO - PROCESS | 1955 | Browser inner width/height: 1024/689 04:11:36 INFO - PROCESS | 1955 | __metrics 04:11:36 INFO - PROCESS | 1955 | 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:11:36 INFO - PROCESS | 1955 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:11:37 INFO - TEST-INFO | 1955: exit 0 04:11:37 INFO - Browser initialized. 04:11:37 INFO - Running cycle 1/1 for kraken test... 04:11:37 INFO - TEST-INFO | started process 1956 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/T/tmp3ba23I/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:11:49 INFO - PROCESS | 1956 | RSS: Main: 232173568 04:11:49 INFO - PROCESS | 1956 | 04:11:52 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:56434/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:56434/tests/kraken/driver.html?testName=audio-beat-detection) 04:11:53 INFO - PROCESS | 1956 | RSS: Main: 284139520 04:11:53 INFO - PROCESS | 1956 | 04:11:55 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:56434/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:56434/tests/kraken/driver.html?testName=audio-dft) 04:11:56 INFO - PROCESS | 1956 | RSS: Main: 286867456 04:11:56 INFO - PROCESS | 1956 | 04:12:00 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:56434/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:56434/tests/kraken/driver.html?testName=audio-fft) 04:12:00 INFO - PROCESS | 1956 | RSS: Main: 376360960 04:12:00 INFO - PROCESS | 1956 | 04:12:02 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:56434/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:56434/tests/kraken/driver.html?testName=audio-oscillator) 04:12:03 INFO - PROCESS | 1956 | RSS: Main: 281423872 04:12:03 INFO - PROCESS | 1956 | 04:12:05 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:56434/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:56434/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:12:05 INFO - PROCESS | 1956 | RSS: Main: 282816512 04:12:05 INFO - PROCESS | 1956 | 04:12:09 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:56434/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:56434/tests/kraken/driver.html?testName=imaging-darkroom) 04:12:09 INFO - PROCESS | 1956 | RSS: Main: 326111232 04:12:09 INFO - PROCESS | 1956 | 04:12:12 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:56434/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:56434/tests/kraken/driver.html?testName=imaging-desaturate) 04:12:13 INFO - PROCESS | 1956 | RSS: Main: 327786496 04:12:13 INFO - PROCESS | 1956 | 04:12:16 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:56434/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:56434/tests/kraken/driver.html?testName=json-parse-financial) 04:12:17 INFO - PROCESS | 1956 | RSS: Main: 325906432 04:12:17 INFO - PROCESS | 1956 | 04:12:18 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:56434/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:56434/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:12:19 INFO - PROCESS | 1956 | RSS: Main: 299753472 04:12:19 INFO - PROCESS | 1956 | 04:12:21 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:56434/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:56434/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:12:21 INFO - PROCESS | 1956 | RSS: Main: 305348608 04:12:21 INFO - PROCESS | 1956 | 04:12:24 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:56434/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:56434/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:12:24 INFO - PROCESS | 1956 | RSS: Main: 313053184 04:12:24 INFO - PROCESS | 1956 | 04:12:27 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:56434/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:56434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:12:28 INFO - PROCESS | 1956 | RSS: Main: 323891200 04:12:28 INFO - PROCESS | 1956 | 04:12:31 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:56434/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:56434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:12:32 INFO - PROCESS | 1956 | RSS: Main: 318410752 04:12:32 INFO - PROCESS | 1956 | 04:12:33 INFO - PROCESS | 1956 | Cycle 1(1): loaded http://localhost:56434/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:56434/tests/kraken/driver.html?testName=ai-astar) 04:12:34 INFO - PROCESS | 1956 | RSS: Main: 362487808 04:12:34 INFO - PROCESS | 1956 | 04:12:34 INFO - PROCESS | 1956 | __start_tp_report 04:12:34 INFO - PROCESS | 1956 | _x_x_mozilla_page_load 04:12:34 INFO - PROCESS | 1956 | _x_x_mozilla_page_load_details 04:12:34 INFO - PROCESS | 1956 | |i|pagename|runs| 04:12:34 INFO - PROCESS | 1956 | |0;ai-astar;114;115;114;114;114;116;113;113;114;123 04:12:34 INFO - PROCESS | 1956 | |1;audio-beat-detection;131;112;109;143;112;110;109;108;128;108 04:12:34 INFO - PROCESS | 1956 | |2;audio-dft;185;191;256;218;180;183;186;185;183;185 04:12:34 INFO - PROCESS | 1956 | |3;audio-fft;80;60;60;92;60;59;62;61;78;59 04:12:34 INFO - PROCESS | 1956 | |4;audio-oscillator;93;68;89;71;70;69;85;70;68;83 04:12:34 INFO - PROCESS | 1956 | |5;imaging-gaussian-blur;86;86;87;87;86;91;135;86;86;86 04:12:34 INFO - PROCESS | 1956 | |6;imaging-darkroom;95;94;102;138;95;95;94;94;94;94 04:12:34 INFO - PROCESS | 1956 | |7;imaging-desaturate;86;84;85;84;87;83;83;86;86;86 04:12:34 INFO - PROCESS | 1956 | |8;json-parse-financial;62;62;59;61;62;62;60;61;64;60 04:12:34 INFO - PROCESS | 1956 | |9;json-stringify-tinderbox;54;57;66;68;61;58;58;59;58;60 04:12:34 INFO - PROCESS | 1956 | |10;stanford-crypto-aes;90;90;91;86;88;89;86;89;87;88 04:12:34 INFO - PROCESS | 1956 | |11;stanford-crypto-ccm;142;142;149;140;139;140;138;139;183;189 04:12:34 INFO - PROCESS | 1956 | |12;stanford-crypto-pbkdf2;169;171;149;224;233;171;168;155;145;238 04:12:34 INFO - PROCESS | 1956 | |13;stanford-crypto-sha256-iterative;68;69;67;68;67;66;67;72;84;82 04:12:34 INFO - PROCESS | 1956 | __end_tp_report 04:12:34 INFO - PROCESS | 1956 | __start_cc_report 04:12:34 INFO - PROCESS | 1956 | _x_x_mozilla_cycle_collect,2202 04:12:34 INFO - PROCESS | 1956 | __end_cc_report 04:12:34 INFO - PROCESS | 1956 | __startTimestamp1488543154208__endTimestamp 04:12:34 INFO - PROCESS | 1956 | 04:12:34 INFO - PROCESS | 1956 | ------- Summary: start ------- 04:12:34 INFO - PROCESS | 1956 | Number of tests: 14 04:12:34 INFO - PROCESS | 1956 | 04:12:34 INFO - PROCESS | 1956 | [#0] ai-astar Cycles:10 Average:115.00 Median:114.00 stddev:2.94 (2.6%) stddev-sans-first:3.10 04:12:34 INFO - PROCESS | 1956 | Values: 114.0 115.0 114.0 114.0 114.0 116.0 113.0 113.0 114.0 123.0 04:12:34 INFO - PROCESS | 1956 | 04:12:34 INFO - PROCESS | 1956 | [#1] audio-beat-detection Cycles:10 Average:117.00 Median:112.00 stddev:12.39 (11.1%) stddev-sans-first:12.06 04:12:34 INFO - PROCESS | 1956 | Values: 131.0 112.0 109.0 143.0 112.0 110.0 109.0 108.0 128.0 108.0 04:12:34 INFO - PROCESS | 1956 | 04:12:34 INFO - PROCESS | 1956 | [#2] audio-dft Cycles:10 Average:195.20 Median:185.50 stddev:23.94 (12.9%) stddev-sans-first:25.11 04:12:34 INFO - PROCESS | 1956 | Values: 185.0 191.0 256.0 218.0 180.0 183.0 186.0 185.0 183.0 185.0 04:12:34 INFO - PROCESS | 1956 | 04:12:34 INFO - PROCESS | 1956 | [#3] audio-fft Cycles:10 Average:67.10 Median:61.50 stddev:11.79 (19.2%) stddev-sans-first:11.54 04:12:34 INFO - PROCESS | 1956 | Values: 80.0 60.0 60.0 92.0 60.0 59.0 62.0 61.0 78.0 59.0 04:12:34 INFO - PROCESS | 1956 | 04:12:34 INFO - PROCESS | 1956 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:77.00 stddev:9.77 (12.7%) stddev-sans-first:8.36 04:12:34 INFO - PROCESS | 1956 | Values: 93.0 68.0 89.0 71.0 70.0 69.0 85.0 70.0 68.0 83.0 04:12:34 INFO - PROCESS | 1956 | 04:12:34 INFO - PROCESS | 1956 | [#5] imaging-gaussian-blur Cycles:10 Average:91.60 Median:86.00 stddev:15.33 (17.8%) stddev-sans-first:16.12 04:12:34 INFO - PROCESS | 1956 | Values: 86.0 86.0 87.0 87.0 86.0 91.0 135.0 86.0 86.0 86.0 04:12:34 INFO - PROCESS | 1956 | 04:12:34 INFO - PROCESS | 1956 | [#6] imaging-darkroom Cycles:10 Average:99.50 Median:94.00 stddev:13.75 (14.6%) stddev-sans-first:14.48 04:12:34 INFO - PROCESS | 1956 | Values: 95.0 94.0 102.0 138.0 95.0 95.0 94.0 94.0 94.0 94.0 04:12:34 INFO - PROCESS | 1956 | 04:12:34 INFO - PROCESS | 1956 | [#7] imaging-desaturate Cycles:10 Average:85.00 Median:86.00 stddev:1.41 (1.6%) stddev-sans-first:1.45 04:12:34 INFO - PROCESS | 1956 | Values: 86.0 84.0 85.0 84.0 87.0 83.0 83.0 86.0 86.0 86.0 04:12:34 INFO - PROCESS | 1956 | 04:12:34 INFO - PROCESS | 1956 | [#8] json-parse-financial Cycles:10 Average:61.30 Median:62.00 stddev:1.42 (2.3%) stddev-sans-first:1.48 04:12:34 INFO - PROCESS | 1956 | Values: 62.0 62.0 59.0 61.0 62.0 62.0 60.0 61.0 64.0 60.0 04:12:34 INFO - PROCESS | 1956 | 04:12:34 INFO - PROCESS | 1956 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:59.50 stddev:4.20 (7.1%) stddev-sans-first:3.88 04:12:34 INFO - PROCESS | 1956 | Values: 54.0 57.0 66.0 68.0 61.0 58.0 58.0 59.0 58.0 60.0 04:12:34 INFO - PROCESS | 1956 | 04:12:34 INFO - PROCESS | 1956 | [#10] stanford-crypto-aes Cycles:10 Average:88.40 Median:89.00 stddev:1.71 (1.9%) stddev-sans-first:1.72 04:12:34 INFO - PROCESS | 1956 | Values: 90.0 90.0 91.0 86.0 88.0 89.0 86.0 89.0 87.0 88.0 04:12:34 INFO - PROCESS | 1956 | 04:12:34 INFO - PROCESS | 1956 | [#11] stanford-crypto-ccm Cycles:10 Average:150.10 Median:142.00 stddev:19.22 (13.5%) stddev-sans-first:20.16 04:12:34 INFO - PROCESS | 1956 | Values: 142.0 142.0 149.0 140.0 139.0 140.0 138.0 139.0 183.0 189.0 04:12:34 INFO - PROCESS | 1956 | 04:12:34 INFO - PROCESS | 1956 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:182.30 Median:171.00 stddev:35.42 (20.7%) stddev-sans-first:37.25 04:12:34 INFO - PROCESS | 1956 | Values: 169.0 171.0 149.0 224.0 233.0 171.0 168.0 155.0 145.0 238.0 04:12:34 INFO - PROCESS | 1956 | 04:12:34 INFO - PROCESS | 1956 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.00 Median:68.50 stddev:6.55 (9.6%) stddev-sans-first:6.86 04:12:34 INFO - PROCESS | 1956 | Values: 68.0 69.0 67.0 68.0 67.0 66.0 67.0 72.0 84.0 82.0 04:12:34 INFO - PROCESS | 1956 | -------- Summary: end -------- 04:12:34 INFO - PROCESS | 1956 | 04:12:35 INFO - TEST-INFO | 1956: exit 0 04:12:35 INFO - TEST-OK | kraken | took 61351ms 04:12:35 INFO - SUITE-END | took 1181s 04:12:35 INFO - Completed test suite (00:19:41) 04:12:35 INFO - javascript benchmark 04:12:35 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7495.1893048167385, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2662.4142688608504, 3314.685104915033, 3335.4830001349783, 3353.161709572607, 3389.2204792897633, 5621.156826476031, 5708.657480551165, 5716.0, 5781.161731548928, 5816.767329306833, 5693.544516438686, 5730.36965933747, 5784.045632470647, 5796.8260952171395, 5808.970955145219, 4315.331123675835, 5190.92213616796, 5194.610404219679, 5261.579073674096, 5274.129768588178, 5357.0, 5365.731713414333, 5370.570354371641, 5391.892162156754, 5423.0, 5160.019596276733, 5207.895842083175, 5221.477852214748, 5259.710715910604, 5327.440618735016, 5229.764660590283, 5235.267062611238, 5284.682919024833, 5288.259643649853, 5340.225667278261, 5212.556932660728, 5234.450382709799, 5243.659162154486, 5246.737663116829, 5272.833874926707, 5576.33084029915, 5773.595848290579, 5774.2782152230975, 5791.710414479301, 5816.069428891357, 5105.770240339194, 6137.438273608336, 6193.535484838655, 6206.565540412173, 6211.565190436671, 6111.478540206961, 6252.3747625237565, 6266.655333956631, 6268.373162683741, 6290.119383286344, 5906.291245050578, 5911.142884281755, 5972.5520585955355, 5973.551983601204, 5984.670843103628, 6357.364263573606, 6366.586171898812, 6372.203474565679, 6374.681265936684, 6379.74481020754, 6031.668258245751, 6077.787277445268, 6083.847903802441, 6238.469730072904, 6241.126242326078, 6193.102000209944, 6196.752129914753, 6198.566100373021, 6199.3490683477585, 6212.751489940442, 6184.8763024739255, 6199.876002480015, 6240.00159974402, 6245.594036387621, 6291.591046581958, 6272.498200143978, 6280.748770049238, 6282.308946015934, 6288.811335659938, 6297.118403423525, 5076.44159142494, 5079.568236699848, 5086.287919691246, 5091.719955402488, 5108.106081435808, 4384.69307148503, 4411.779411029435, 4424.048829501673, 4433.733975961452, 4533.320001999727, 5791.362950075489, 5796.768129274866, 5809.390014048548, 5843.2695913010875, 5867.765289388462, 6280.717367718464, 6281.528885333618, 6284.12022316876, 6298.275698294663, 6310.558260921784, 5620.831375058755, 5687.090065589568, 5812.244408226903, 5832.212651292106, 5852.268466441695, 5468.398476167618, 5508.9724551376985, 5514.228008078872, 5546.389897111315, 5598.440155984369, 6412.396900774899, 6425.935740642627, 6427.035944608346, 6432.614043157426, 6449.6130232186215, 6252.343503932022, 6280.152179455715, 6296.370362963667, 6319.399657032574, 6323.114763932961, 6200.131981522501, 6216.098665693358, 6234.844128896814, 6237.5009999200865, 6280.717367718372, 6176.413240742122, 6178.0, 6180.66006369636, 6183.3816618337805, 6194.473469755121, 6149.754009839735, 6232.688365581794, 6260.937390626035, 6298.622082674871, 6336.7148478319505, 6122.938770612415, 6208.192934918432, 6217.067439884054, 6217.347178546188, 6226.1905952225925, 5969.8806023878415, 6197.876042479035, 6224.502039836892, 6224.502039836892, 6228.968855155696, 5877.529797616266, 5939.406059394026, 5939.554533410098, 5947.553933455095, 5953.583249172516, 6129.389354848411, 6137.101203255209, 6141.117811339906, 6223.906641400292, 6230.719617617127, 5991.831592839355, 6020.096985452217, 6023.36754640774, 6024.909626355696, 6063.787767428119], "value": 5737.620944083433, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [641.9069234960931, 847.8219573889482, 869.7782065573277, 871.9825603487934, 873.0789017586444, 28167.718322816792, 28398.14805555834, 28452.57321140182, 29471.115866523985, 39999.0, 39441.60558394423, 42293.15413691724, 42295.0, 42302.0, 42345.576544234624, 9255.953720231406, 9426.905730942672, 9428.575714092882, 9428.952855235748, 9467.24262059037, 7475.476716629811, 7635.442126887499, 9222.400543964653, 9343.532823358839, 9352.953235233814, 7614.543127412373, 7646.311831935125, 7654.043244594426, 11074.280171788849, 11305.321680699184, 9327.39371940825, 11284.661460156127, 11288.153388495895, 11301.321920684784, 11302.830457543185, 9367.672131475434, 10903.236773425864, 10910.727231819268, 10977.39624320662, 10984.835227471594, 27555.586666200023, 27822.721772782217, 27854.860725696446, 38821.41767873484, 39109.0, 3065.5401689746495, 3737.588865224823, 3760.3795373763296, 3831.942520862189, 3958.960410395888, 27388.863055684793, 27989.300267493272, 28064.438711225866, 28455.430891382057, 28515.42969140626, 2440.865752383618, 2825.971740282612, 2840.3041254892682, 2858.085412667947, 2955.0, 326728.0, 334330.0, 334524.0, 335433.0, 336794.31602842076, 50918.23622645663, 51536.0, 51559.711007225116, 51638.22542661863, 51649.96700065977, 43157.784211078746, 43862.78068609637, 52805.7359713199, 53740.462595373545, 54004.0, 11656.53373865036, 13696.246706431242, 13795.655108622364, 13809.861901381058, 13810.240436776074, 9720.368176068532, 11674.241174323643, 11795.882041179479, 11799.76400472003, 12001.519939202333, 12335.198212116184, 12339.197952133083, 12351.073669474825, 12371.628851134481, 12400.503979840885, 5444.891102177934, 5465.945340546623, 5470.753816078286, 5472.945270547323, 5490.203920431515, 1006.642641862143, 1045.1220974381556, 1089.84742136101, 1122.71370800447, 1174.8531433570804, 25362.0, 25429.491410171693, 25559.23322300334, 25883.482330353287, 26528.60207096895, 1033.7674023344687, 1239.330761388858, 1254.4668515880714, 1261.8801213884667, 1267.524678245658, 12744.36278186087, 13336.399862006234, 13452.394642240926, 13591.320433978262, 13625.454981800616, 394781.0, 396152.0, 397694.0, 397718.0, 397833.0, 54722.0, 54761.61907047427, 54825.45174548204, 54837.0, 54909.0, 1366.4602482019548, 1441.4378392426752, 1443.7329094117622, 1443.9711205776036, 1454.0621299262127, 24151.316183367257, 25127.3667211638, 25140.62289065629, 25204.495910082063, 25252.0, 36592.0, 46194.307085394415, 46256.53743462657, 46342.30486542772, 46350.30474542952, 372288.0, 372660.0, 372899.0, 520593.0, 534607.0, 28572.999945001826, 36342.63657363393, 36721.63278367182, 37183.211259155134, 37394.813025934694, 43763.562364375946, 44836.551634483236, 44896.87757806081, 45872.0, 46911.765441172574, 32330.030099097065, 37211.441828373136, 38610.841674749805, 38704.41943370795, 39791.0, 37241.068973275884, 37283.627163728015, 37678.0, 39133.0, 39220.038998049415, 38621.6137838618, 38863.41704874373, 38956.41565376465, 39839.0, 40109.79945100256, 31067.912623058084, 33933.402291533974, 34305.48541771826, 34578.0, 34694.47958280678, 25366.619500707875, 25559.361015974748, 25738.485230295664, 25817.612735809354, 25944.72197117906], "value": 18457.55692802794, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [380.8838304317182, 395.8772780438064, 396.7520299812617, 411.16738604326235, 440.60125586344367, 12380.400969549466, 19898.900505497488, 20820.99999999998, 21621.3513594592, 21741.78258217417, 17848.464546063606, 21218.89390553049, 21588.0, 22273.0, 22404.32787016388, 6490.2860685324695, 6691.6319602421845, 6715.059891615178, 6771.0, 6781.220159681626, 6389.904151437732, 6542.705578248991, 6567.901481477782, 6568.7372505099975, 6648.601083934956, 6569.0, 6576.6711664416825, 7037.788866333993, 7363.631818409085, 7459.030326057605, 7273.272672732684, 7274.672639731225, 7299.02926209923, 7361.5583065015735, 7363.889541656907, 6989.44084473246, 7174.246704096047, 7176.461765367566, 7181.245969173214, 7197.028401165828, 24897.751022489723, 25036.624450633255, 25650.87174564134, 25877.223683289532, 26097.608535871976, 2823.336515918778, 2834.4897918374686, 2847.145856243119, 2848.7863410244313, 2854.743073123408, 14463.49377771773, 14661.853381466262, 15021.948463607552, 15419.103023810574, 16110.952788068738, 1861.9813801861944, 1862.608852141052, 1876.5121068522146, 1879.1074239736154, 1885.9528511787178, 140742.29628851893, 150348.9581250246, 151705.72441413387, 158813.82372352603, 161970.0, 14716.852831471548, 18834.623307533773, 18917.14872830726, 19238.941858197933, 19425.222991080198, 33053.834730826195, 39222.21555568872, 41859.7907010463, 42054.789726051786, 42203.36694949578, 8722.193636695123, 10865.619703310345, 11167.38579378142, 11171.218014739054, 11192.720181995352, 8525.488470691778, 8566.258797184966, 8777.91222087771, 8902.46279810251, 9086.136817002507, 9493.0, 10080.69757907264, 10120.898791012143, 10778.407187604756, 10931.125509959184, 3905.2970465316516, 4050.8987275318354, 4052.979735101306, 4053.3312003519677, 4069.409935559327, 934.3412893909913, 965.3821554205314, 985.1675334342469, 1013.8428543575758, 1030.7526193713454, 19854.90072549657, 20607.0, 20632.17471301131, 20690.068946897427, 20909.28469802049, 876.8158686675743, 934.5514153206499, 953.8378475659155, 966.7776411425411, 991.4101109839634, 10195.28632995698, 10646.562255363924, 10705.9464702676, 10731.0, 10780.78438431227, 653968.0, 681397.0, 691736.0, 709033.0, 715023.0, 106359.0, 146809.0, 151730.0, 153834.38573335516, 154771.0, 1018.1447584029303, 1058.1376178414569, 1105.7788442311569, 1107.5293000474767, 1107.9944600277108, 17637.765356424927, 19107.617847643247, 19382.8061719381, 19647.214111435384, 19709.211631534577, 39580.0, 51759.2236116451, 56275.87448251094, 57781.13328300163, 57899.0, 73992.63003684947, 79858.60070699609, 81444.0, 82437.58781206056, 82581.76127357974, 7303.598302093435, 9462.243020558477, 9599.904000960181, 9914.702558923243, 10232.209363361531, 12552.184108032949, 12690.87309126897, 12697.492100315883, 12952.222866628032, 12964.351782410653, 10666.46667666629, 10706.73233169177, 10868.402237876993, 11038.116950643769, 11052.0, 8433.367497437594, 9689.951550242204, 10190.235732319958, 10212.387256764618, 10212.897871021492, 10906.50920708554, 11120.721981950515, 11146.777064458827, 11153.386563739072, 11209.663710088711, 9692.903070969482, 9847.113759761656, 9972.700818975442, 10005.599776008878, 10011.299209055296, 9658.275629327969, 10339.0, 10635.308704934154, 10875.184361172785, 10983.450827458755], "value": 11197.43166050766, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1548.3651702801853, 1553.8989965652224, 1573.2762929052635, 1589.3324803582493, 1592.3948899418222, 10345.793084138313, 10955.890441095597, 10958.835617465744, 10969.780604387908, 10988.945055274722, 10544.841827372577, 10658.946705266482, 10901.672949811518, 10931.781364372708, 11076.889231107687, 2334.5914464968646, 2357.3870793593705, 2369.9289021329387, 2374.489484760776, 2379.2267513058237, 2338.1465764995737, 2367.585672507313, 2373.620220764678, 2373.750756170603, 2376.7266764322067, 2306.9538609227807, 2307.769223077687, 2331.1957374705785, 2332.043862016565, 2339.801116905065, 2289.553537060274, 2293.8738369389675, 2313.6580783145737, 2320.1995311617466, 2320.5938960681815, 2261.344210179046, 2328.406256404623, 2332.3702600297993, 2332.6384410416244, 2334.2063698342645, 10942.945285273603, 11047.83428248577, 11058.944705276503, 11060.391678457681, 11068.612598559092, 5392.568594512469, 5618.0, 5782.3639399666, 5814.883702325972, 5817.970910145422, 3345.1637090727318, 3503.8248087595516, 3547.5565554305713, 3583.605803361628, 3586.22896077342, 1066.7759770448215, 1088.450332582049, 1135.403912945702, 1141.5148561861176, 1150.177622999551, 13638.93180534091, 14006.369713362923, 14019.649508762159, 15004.624884377869, 15038.774418383733, 4205.137946720914, 4316.611504964569, 4328.11273688893, 4328.978355108205, 4351.151525452507, 9457.574409151604, 11174.553017879194, 11521.0, 11628.0, 11631.6510504685, 5522.6134170607675, 5556.833295001075, 5588.720563971785, 5591.077472217039, 5595.7481913313995, 4897.706137631753, 5188.092083885305, 5254.527092561688, 5255.13290307095, 5261.736913154327, 3633.255182687543, 3766.4350347448103, 3802.239552089593, 3840.8271627776817, 3863.5363756349416, 986.1913231150388, 987.8468837330225, 996.2776986684596, 1003.8895721470633, 1008.8789345278614, 878.7407714724171, 914.07221670005, 915.9084091590921, 941.3222479814523, 941.6892425499568, 6105.572609917352, 6258.9359808832605, 6290.77329920661, 6343.9682801585695, 6510.446612037935, 849.3884403229665, 952.5189779161618, 963.6723514005132, 1002.0830939690247, 1005.0853723111933, 3279.7212236960127, 3909.9609003909595, 4053.6554392876938, 4147.688923330762, 4165.97917010413, 12586.0, 13235.27206003679, 13315.533956311676, 13449.058565900488, 13463.798043029363, 13049.217046977212, 13132.737345253041, 13334.733305333839, 13365.599032029055, 13379.929605631527, 9833.311668183302, 9953.950230248947, 9964.950175249078, 10061.748456288651, 10073.748156296151, 6331.27190373113, 6353.745850165941, 6412.839679008062, 6482.118808918263, 6487.253965793805, 9549.28380371461, 11777.293362398283, 11917.22538035025, 11956.10329225329, 12002.339871307162, 11991.160618756603, 12024.33866137371, 12220.144589878622, 12250.754984900073, 12380.133390662568, 8154.0215174179475, 8320.417570769989, 8323.583820808813, 8327.50034997902, 8329.375296852639, 9865.901340986498, 9872.950635247065, 9904.306698531034, 9981.101700846959, 10028.29801913859, 8674.566271686517, 8715.30277577805, 8780.736577902673, 8955.776105597151, 8973.641054357753, 8508.361872859436, 8551.74344769658, 8635.870461943201, 8710.47737135774, 8711.303095752452, 7416.369608583331, 7491.175970643334, 7512.474126811071, 7587.165411804586, 7609.695612175451, 5665.773369065356, 5802.506786923159, 5816.82549523515, 5889.852753681193, 5916.437938395846, 5107.2594473800345, 5509.311336082989, 5921.61509501881, 5941.168236446987, 5967.254093238345], "value": 4977.37766630682, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [341.6419731567021, 350.74395691145463, 372.12550506310157, 375.66941091839175, 377.09873402567865, 4268.423762792026, 4447.642749342854, 5296.496832800887, 5301.045811753887, 5304.6286759926825, 5071.898562028758, 5222.92165617516, 5276.393214780302, 5287.47125287471, 5296.470352964701, 4157.625813676768, 4174.373843923406, 4348.695591308609, 4401.66987475939, 4446.822127114928, 4388.188185185751, 4395.362672412498, 4395.626371758404, 4413.9185899454515, 4414.13924284763, 3658.762180458275, 4384.89037774055, 4413.58070983256, 4431.43854462649, 4476.932846007313, 4001.8399264029404, 4057.6753859691153, 4195.601417865298, 4250.404943307939, 4426.9154057255855, 4025.3156963316305, 4040.5555388907196, 4061.6344528992236, 4074.5517993020744, 4095.508538975342, 4787.736674482902, 4788.545088216614, 5072.239164125411, 5136.0241554104605, 5178.300929374562, 4185.686073544496, 4622.6070783983405, 4857.441394239637, 5034.370703662043, 5079.875876336064, 4630.699004564726, 5070.442251352349, 5292.761825717852, 5389.948959952811, 5611.326640803089, 4460.776961151962, 4485.9102817943785, 4505.774711264424, 4518.43519560055, 4537.5706652404715, 4314.848980285707, 5373.274607927919, 5871.941280587225, 5909.852253693692, 5991.64050156992, 3798.5061941947924, 4514.367988481616, 4519.322101684708, 4526.6152377047665, 4573.131105090022, 3910.9608903911167, 4144.585541445831, 4458.754768487699, 4632.795473176998, 4634.235351167087, 3864.3962755456173, 4124.91750164995, 4879.243472349951, 4963.337282010567, 5031.471695471996, 5173.974130129401, 5538.16927460876, 5600.439956004367, 5665.49010589049, 5679.545636349165, 1310.377570653951, 1381.8134551835574, 1413.2792275939346, 1503.7067771784616, 1521.5359315408907, 1075.4300220882944, 1099.4612639806437, 1135.40391294571, 1143.416857402714, 1152.5850693750244, 4515.419603138875, 4705.364775755298, 4905.583025442877, 4946.554810067039, 4970.428400733889, 5078.923816142761, 5315.847081931824, 5385.78456861729, 5411.972940135274, 5487.765252818084, 4518.012074687127, 4543.6365090793315, 4735.408073990751, 4953.50464953509, 5338.9322135572265, 2582.7804636606097, 2722.986385068062, 2819.224713203844, 2847.8291302521916, 2850.686424493304, 4798.23228283473, 4799.833049285226, 5492.517020404468, 5642.85892852682, 5737.328110009597, 4653.277832467977, 4711.963368059021, 4975.019984012775, 5466.426025267289, 5550.973069981986, 4733.337332773414, 5208.0469823816065, 5358.4373640767935, 5659.236003139606, 5766.740496677576, 4617.215073437591, 4809.807607695653, 5391.083515802401, 5484.369297530835, 5505.779768809202, 4732.479427263067, 4783.856484305476, 4850.871188083737, 5403.02745505797, 5489.780408783604, 5521.631804599111, 5732.226149469769, 5741.421109194837, 5744.834994628861, 5756.366799651951, 3612.8554857806444, 3868.8259028343227, 4254.234237837219, 4344.5221025686515, 4375.212461756914, 4580.228961478258, 5274.578033757367, 5419.593530485151, 5725.112607545837, 5809.896119737236, 4504.369388285577, 4856.514348565256, 5559.221708960829, 5593.244911936837, 5600.411956744646, 4666.250156191428, 5029.717422057498, 5558.666480011212, 5568.415316391883, 5589.55283577321, 5073.315102461268, 5106.770195341144, 5167.22491626244, 5474.742528195718, 5495.499547705865, 4951.702897825998, 5352.518273355417, 5509.283793106871, 5583.6878333592385, 5631.267935168566, 4154.273002224538, 4672.836450724209, 4689.296605509201, 5108.463611320906, 5449.782008719607], "value": 4154.120204066195, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [575.3469811763647, 732.1653315220649, 748.2330611123598, 777.9533228006317, 839.5634270179506, 14406.423743050278, 15190.468333608325, 15206.163660998669, 15217.771733423993, 15226.923865380671, 13492.190468571893, 13687.863121368784, 13693.726125477484, 13803.65490862729, 13835.377408016639, 894.3962825093068, 958.314804914486, 976.0971101730906, 977.4575110813496, 977.7066879936026, 784.6155383861924, 959.0744931141447, 961.0677642686618, 964.5852283518119, 967.4002118686424, 976.8827740671129, 1011.5397494140149, 1011.6914341125954, 1011.8482227665835, 1014.5688082564917, 1000.7348052765986, 1000.9999999999964, 1001.0540039662521, 1001.1090129784498, 1004.437514991607, 751.0086685575043, 753.3521171792254, 753.7437271327775, 755.7770457714932, 755.928186822251, 13891.652708682263, 14888.776668349983, 15422.997505162128, 15521.991070580376, 15528.301226444837, 13774.380152893043, 13788.448462061506, 13800.95312090178, 13886.180479554192, 14006.509772158028, 11350.71623209418, 11467.139964502696, 11631.941840290829, 11649.534018639244, 11976.940115299454, 3596.9477442324455, 3640.2537479816574, 3679.2089700714473, 3679.2457546202963, 3686.5207523022104, 98588.0, 99116.50441747745, 100244.0, 100274.0, 101025.98974010239, 10114.494275286206, 10242.0, 10535.157187424988, 10614.257002009785, 10701.09040731531, 21710.565788684136, 22033.245844269466, 22036.669449958263, 22078.558428831653, 22091.558168836535, 7056.647167641598, 7097.858042839114, 7178.17450993132, 7318.194998550155, 7362.116546014512, 4061.6750659947133, 4122.9381559276635, 4137.689673274516, 4206.179794940019, 4212.010177608259, 3041.285297954979, 3106.891258805931, 3121.984390078035, 3123.6720144384512, 3130.7964982276535, 537.4437457231746, 612.5895649914568, 620.1442010026225, 624.2290770897937, 635.6948664640905, 643.9903401448983, 660.6102399584269, 663.867226554691, 673.7675501951819, 683.7265093962454, 8825.514596697114, 9210.309226808016, 9517.384743001663, 9808.324287349991, 9927.255455840841, 651.9178164247327, 658.6838317607575, 683.5628363406109, 696.7631005458169, 703.6165289917008, 3839.0, 4343.609075183249, 4666.743329116864, 4672.556107169813, 4737.8341758038305, 71968.2803171972, 74065.25934740584, 77407.22592774, 80413.59793200997, 101351.47972780414, 47765.31000380346, 58776.41223587709, 60738.696306518184, 76702.46595068068, 80210.0, 59937.400625993185, 60092.0, 62212.0, 63868.36131638624, 64248.0, 8752.64989400417, 9296.205660857073, 9384.76538086526, 9422.246220302497, 9537.809243814945, 39515.604843951194, 42496.0, 44477.33284000678, 47481.52518474771, 47840.521594783604, 65511.672441637485, 67787.0, 68647.31352686409, 69795.6510217466, 70448.64775676088, 12298.049655076566, 12593.559225427067, 12612.0, 12627.558035468715, 12798.424070917017, 12036.819447708467, 12356.814647780111, 14051.36768845384, 14491.637709057359, 14546.141870147232, 10815.405152716676, 13380.264085475392, 13485.0, 13995.930020349833, 14019.088759230617, 13165.275909824668, 13286.867131328563, 13296.401661925043, 13470.865291346961, 13851.0, 10602.681919542118, 12682.302473364054, 12852.614421567368, 13069.215847048827, 13732.45070197221, 10653.820783945448, 10865.565377384815, 10929.07102896231, 10939.507722152362, 11413.144014198802, 8955.729971776558, 9175.770605734642, 10452.41268598646, 10675.839862401916, 10847.837282440927], "value": 7230.183004840457, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1459.9999999999998, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 114.0, 114.0, 116.0, 113.0, 113.0, 114.0, 123.0], "value": 115.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [131.0, 112.0, 109.0, 143.0, 112.0, 110.0, 109.0, 108.0, 128.0, 108.0], "value": 117.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 191.0, 256.0, 218.0, 180.0, 183.0, 186.0, 185.0, 183.0, 185.0], "value": 195.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 60.0, 60.0, 92.0, 60.0, 59.0, 62.0, 61.0, 78.0, 59.0], "value": 67.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 68.0, 89.0, 71.0, 70.0, 69.0, 85.0, 70.0, 68.0, 83.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 87.0, 86.0, 91.0, 135.0, 86.0, 86.0, 86.0], "value": 91.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 94.0, 102.0, 138.0, 95.0, 95.0, 94.0, 94.0, 94.0, 94.0], "value": 99.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 85.0, 84.0, 87.0, 83.0, 83.0, 86.0, 86.0, 86.0], "value": 85.0, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 62.0, 59.0, 61.0, 62.0, 62.0, 60.0, 61.0, 64.0, 60.0], "value": 61.3, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 57.0, 66.0, 68.0, 61.0, 58.0, 58.0, 59.0, 58.0, 60.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 91.0, 86.0, 88.0, 89.0, 86.0, 89.0, 87.0, 88.0], "value": 88.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 142.0, 149.0, 140.0, 139.0, 140.0, 138.0, 139.0, 183.0, 189.0], "value": 150.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 149.0, 224.0, 233.0, 171.0, 168.0, 155.0, 145.0, 238.0], "value": 182.3, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 67.0, 68.0, 67.0, 66.0, 67.0, 72.0, 84.0, 82.0], "value": 71.0, "unit": "score"}]}]} 04:12:35 INFO - Return code: 0 04:12:35 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:12:35 ERROR - # TBPL SUCCESS # 04:12:35 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:12:35 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:12:35 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:12:35 INFO - 2017-03-03 04:12:35.485 screenresolution[1960:23323] starting screenresolution argv=screenresolution get 04:12:35 INFO - 2017-03-03 04:12:35.488 screenresolution[1960:23323] Display 0: 1600x1200x32@60 04:12:35 INFO - 2017-03-03 04:12:35.495 screenresolution[1961:23326] starting screenresolution argv=screenresolution list 04:12:35 INFO - Available Modes on Display 0 04:12:35 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:12:35 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:12:35 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:12:35 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:12:35 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:12:35 INFO - Intel Iris: 04:12:35 INFO - Chipset Model: Intel Iris 04:12:35 INFO - Type: GPU 04:12:35 INFO - Bus: Built-In 04:12:35 INFO - VRAM (Dynamic, Max): 1536 MB 04:12:35 INFO - Vendor: Intel (0x8086) 04:12:35 INFO - Device ID: 0x0a2e 04:12:35 INFO - Revision ID: 0x0009 04:12:35 INFO - Displays: 04:12:35 INFO - Display: 04:12:35 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:12:35 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:12:35 INFO - Display Serial Number: 1600x1200 60 04:12:35 INFO - Main Display: Yes 04:12:35 INFO - Mirror: Off 04:12:35 INFO - Online: Yes 04:12:35 INFO - Rotation: Supported 04:12:35 INFO - Return code: 0 04:12:35 INFO - Running post-action listener: _resource_record_post_action 04:12:35 INFO - [mozharness: 2017-03-03 12:12:35.735104Z] Finished run-tests step (success) 04:12:35 INFO - Running post-run listener: _resource_record_post_run 04:12:35 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 417792; Write bytes: 509471232; Read time: 8; Write time: 1558 04:12:35 INFO - TinderboxPrint: CPU usage
53.7% 04:12:35 INFO - TinderboxPrint: I/O read bytes / time
417,792 / 8 04:12:35 INFO - TinderboxPrint: I/O write bytes / time
509,471,232 / 1,558 04:12:35 INFO - TinderboxPrint: CPU idle
2,228.8 (46.3%) 04:12:35 INFO - TinderboxPrint: CPU system
955.2 (19.9%) 04:12:35 INFO - TinderboxPrint: CPU user
1,625.7 (33.8%) 04:12:35 INFO - TinderboxPrint: Swap in / out
211,222,528 / 0 04:12:35 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203878912; Write bytes: 204166656; Read time: 15413; Write time: 436 04:12:35 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 417792; Write bytes: 295437312; Read time: 8; Write time: 1088 04:12:36 INFO - Running post-run listener: _upload_blobber_files 04:12:36 INFO - Blob upload gear active. 04:12:36 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:12:36 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:12:36 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:12:36 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:12:36 INFO - (blobuploader) - INFO - Open directory for files ... 04:12:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:12:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:37 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:12:37 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:37 INFO - (blobuploader) - INFO - Done attempting. 04:12:37 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:12:37 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:37 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:38 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:12:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:38 INFO - (blobuploader) - INFO - Done attempting. 04:12:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:12:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:39 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:12:39 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:39 INFO - (blobuploader) - INFO - Done attempting. 04:12:39 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:12:39 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:12:39 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:12:41 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:12:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:12:41 INFO - (blobuploader) - INFO - Done attempting. 04:12:41 INFO - (blobuploader) - INFO - Iteration through files over. 04:12:41 INFO - Return code: 0 04:12:41 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:12:41 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:12:41 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca438a387bbc5cee87000e2c26906f6378c5c529cbbfa5b1a985c12c2ea6da84283525671ecdbf25efc4f3dfa35354cccfa5c4ddb79d376824fc75b2150314dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c522a8fbd3425474f768f8b02e4bebed5f644c775b26894047ba2ba2cb0de0694182e7d615c19626c110bb6bef97d400ebd4c993cdced171bc28bee975af7991", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45be08215368bc705472c8f1167212f59b0ff25b958b6f05220aee0f6a4091c42ef17adbd7fbfefcab19e439237bbf33ad42be3e06be5f12f7aa27b88dba1116", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77a9ebf76d5851ebe75ef987bee94b956c0ddecad0ad5613b07f56197493bf5465dddc438d37d727ae280ca6ebc3a663a4f6606674332827eb773a2cde34fb0d"} 04:12:41 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:12:41 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:12:41 INFO - Contents: 04:12:41 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ca438a387bbc5cee87000e2c26906f6378c5c529cbbfa5b1a985c12c2ea6da84283525671ecdbf25efc4f3dfa35354cccfa5c4ddb79d376824fc75b2150314dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c522a8fbd3425474f768f8b02e4bebed5f644c775b26894047ba2ba2cb0de0694182e7d615c19626c110bb6bef97d400ebd4c993cdced171bc28bee975af7991", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45be08215368bc705472c8f1167212f59b0ff25b958b6f05220aee0f6a4091c42ef17adbd7fbfefcab19e439237bbf33ad42be3e06be5f12f7aa27b88dba1116", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77a9ebf76d5851ebe75ef987bee94b956c0ddecad0ad5613b07f56197493bf5465dddc438d37d727ae280ca6ebc3a663a4f6606674332827eb773a2cde34fb0d"} 04:12:41 INFO - Running post-run listener: copy_logs_to_upload_dir 04:12:41 INFO - Copying logs to upload dir... 04:12:41 INFO - mkdir: /builds/slave/test/build/upload/logs 04:12:41 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1284.803799 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 24 secs) (at 2017-03-03 04:12:41.585570) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 04:12:41.589379) ========= 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.bBjd9sJJZh/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.jWrsDST7R2/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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/ca438a387bbc5cee87000e2c26906f6378c5c529cbbfa5b1a985c12c2ea6da84283525671ecdbf25efc4f3dfa35354cccfa5c4ddb79d376824fc75b2150314dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c522a8fbd3425474f768f8b02e4bebed5f644c775b26894047ba2ba2cb0de0694182e7d615c19626c110bb6bef97d400ebd4c993cdced171bc28bee975af7991", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45be08215368bc705472c8f1167212f59b0ff25b958b6f05220aee0f6a4091c42ef17adbd7fbfefcab19e439237bbf33ad42be3e06be5f12f7aa27b88dba1116", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77a9ebf76d5851ebe75ef987bee94b956c0ddecad0ad5613b07f56197493bf5465dddc438d37d727ae280ca6ebc3a663a4f6606674332827eb773a2cde34fb0d"} build_url:https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011004 build_url: 'https://queue.taskcluster.net/v1/task/FKCQYY2PS8KYEBUu8xWTNA/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/ca438a387bbc5cee87000e2c26906f6378c5c529cbbfa5b1a985c12c2ea6da84283525671ecdbf25efc4f3dfa35354cccfa5c4ddb79d376824fc75b2150314dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c522a8fbd3425474f768f8b02e4bebed5f644c775b26894047ba2ba2cb0de0694182e7d615c19626c110bb6bef97d400ebd4c993cdced171bc28bee975af7991", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/45be08215368bc705472c8f1167212f59b0ff25b958b6f05220aee0f6a4091c42ef17adbd7fbfefcab19e439237bbf33ad42be3e06be5f12f7aa27b88dba1116", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/77a9ebf76d5851ebe75ef987bee94b956c0ddecad0ad5613b07f56197493bf5465dddc438d37d727ae280ca6ebc3a663a4f6606674332827eb773a2cde34fb0d"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-03 04:12:41.623484) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 04:12:41.623803) ========= 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.bBjd9sJJZh/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.jWrsDST7R2/Listeners TMPDIR=/var/folders/sz/c6ws_wbn20bfgbb7cxcht_j000000w/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.005271 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-03 04:12:41.672821) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 04:12:41.673139) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-03 04:12:41.673455) ========= ========= Total master_lag: 0.18 =========