builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0325 starttime: 1489147057.19 results: success (0) buildid: 20170310023722 builduid: b49eadd7111646f482e9fdc5bf197a02 revision: e18d3dd20e8d60bb21524e1b6ef4a87288369afe ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 03:57:37.189927) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 03:57:37.190388) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 03:57:37.190664) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 03:57:37.217427) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 03:57:37.217841) ========= 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.4w2b9tEXuQ/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.tGLSUVM05U/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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-10 03:57:37-- 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% 161M=0s 2017-03-10 03:57:37 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.144878 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 03:57:37.386755) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 03:57:37.387067) ========= 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.4w2b9tEXuQ/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.tGLSUVM05U/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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.026345 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 03:57:37.444847) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 03:57:37.445197) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e18d3dd20e8d60bb21524e1b6ef4a87288369afe --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 e18d3dd20e8d60bb21524e1b6ef4a87288369afe --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.4w2b9tEXuQ/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.tGLSUVM05U/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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-10 03:57:37,553 truncating revision to first 12 chars 2017-03-10 03:57:37,553 Setting DEBUG logging. 2017-03-10 03:57:37,553 attempt 1/10 2017-03-10 03:57:37,553 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e18d3dd20e8d?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-10 03:57:38,826 unpacking tar archive at: mozilla-central-e18d3dd20e8d/testing/mozharness/ program finished with exit code 0 elapsedTime=1.544021 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 03:57:39.012869) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 03:57:39.013230) ========= script_repo_revision: e18d3dd20e8d60bb21524e1b6ef4a87288369afe ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 03:57:39.013647) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 03:57:39.013928) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 03:57:39.034199) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-03-10 03:57:39.034599) ========= /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.4w2b9tEXuQ/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.tGLSUVM05U/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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:57:39 INFO - MultiFileLogger online at 20170310 03:57:39 in /builds/slave/test 03:57:39 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:57:39 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 03:57:39 INFO - {'append_to_log': False, 03:57:39 INFO - 'base_work_dir': '/builds/slave/test', 03:57:39 INFO - 'blob_upload_branch': 'Firefox', 03:57:39 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 03:57:39 INFO - 'branch': 'Firefox', 03:57:39 INFO - 'buildbot_json_path': 'buildprops.json', 03:57:39 INFO - 'config_files': ('talos/mac_config.py',), 03:57:39 INFO - 'default_actions': ('clobber', 03:57:39 INFO - 'read-buildbot-config', 03:57:39 INFO - 'download-and-extract', 03:57:39 INFO - 'populate-webroot', 03:57:39 INFO - 'create-virtualenv', 03:57:39 INFO - 'install', 03:57:39 INFO - 'run-tests'), 03:57:39 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 03:57:39 INFO - 'download_minidump_stackwalk': True, 03:57:39 INFO - 'download_symbols': 'ondemand', 03:57:39 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 03:57:39 INFO - 'tooltool.py': '/tools/tooltool.py', 03:57:39 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 03:57:39 INFO - '/tools/misc-python/virtualenv.py')}, 03:57:39 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 03:57:39 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 03:57:39 INFO - 'gecko_profile': False, 03:57:39 INFO - 'gecko_profile_interval': 0, 03:57:39 INFO - 'installer_path': 'installer.exe', 03:57:39 INFO - 'log_level': 'info', 03:57:39 INFO - 'log_name': 'talos', 03:57:39 INFO - 'log_to_console': True, 03:57:39 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 03:57:39 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 03:57:39 INFO - 'opt_config_files': (), 03:57:39 INFO - 'pip_index': False, 03:57:39 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:57:39 INFO - 'cmd': ('bash', 03:57:39 INFO - '-c', 03:57:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:57:39 INFO - 'enabled': True, 03:57:39 INFO - 'halt_on_failure': False, 03:57:39 INFO - 'name': 'check_screen_resolution'},), 03:57:39 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 03:57:39 INFO - 'cmd': ('bash', 03:57:39 INFO - '-c', 03:57:39 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 03:57:39 INFO - 'enabled': True, 03:57:39 INFO - 'halt_on_failure': False, 03:57:39 INFO - 'name': 'check_screen_resolution'},), 03:57:39 INFO - 'run_cmd_checks_enabled': True, 03:57:39 INFO - 'suite': 'dromaeojs', 03:57:39 INFO - 'system_bits': '32', 03:57:39 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 03:57:39 INFO - 'title': 't-yosemite-r7-0325', 03:57:39 INFO - 'tooltool_cache': '/builds/tooltool_cache', 03:57:39 INFO - 'use_talos_json': True, 03:57:39 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 03:57:39 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 03:57:39 INFO - 'work_dir': 'build'} 03:57:39 INFO - [mozharness: 2017-03-10 11:57:39.248782Z] Running clobber step. 03:57:39 INFO - Running pre-action listener: _resource_record_pre_action 03:57:39 INFO - Running main action method: clobber 03:57:39 INFO - rmtree: /builds/slave/test/build 03:57:39 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 03:57:41 INFO - Running post-action listener: _resource_record_post_action 03:57:41 INFO - [mozharness: 2017-03-10 11:57:41.578072Z] Finished clobber step (success) 03:57:41 INFO - [mozharness: 2017-03-10 11:57:41.578244Z] Running read-buildbot-config step. 03:57:41 INFO - Running pre-action listener: _resource_record_pre_action 03:57:41 INFO - Running main action method: read_buildbot_config 03:57:41 INFO - Using buildbot properties: 03:57:41 INFO - { 03:57:41 INFO - "project": "", 03:57:41 INFO - "product": "firefox", 03:57:41 INFO - "script_repo_revision": "production", 03:57:41 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 03:57:41 INFO - "repository": "", 03:57:41 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 03:57:41 INFO - "buildid": "20170310023722", 03:57:41 INFO - "pgo_build": "False", 03:57:41 INFO - "basedir": "/builds/slave/test", 03:57:41 INFO - "buildnumber": 7, 03:57:41 INFO - "slavename": "t-yosemite-r7-0325", 03:57:41 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 03:57:41 INFO - "platform": "yosemite_r7", 03:57:41 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 03:57:41 INFO - "branch": "mozilla-central", 03:57:41 INFO - "repo_path": "mozilla-central", 03:57:41 INFO - "revision": "e18d3dd20e8d60bb21524e1b6ef4a87288369afe", 03:57:41 INFO - "stage_platform": "macosx64", 03:57:41 INFO - "builduid": "b49eadd7111646f482e9fdc5bf197a02", 03:57:41 INFO - "slavebuilddir": "test" 03:57:41 INFO - } 03:57:41 INFO - Found installer url https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 03:57:41 INFO - Running post-action listener: _resource_record_post_action 03:57:41 INFO - [mozharness: 2017-03-10 11:57:41.583887Z] Finished read-buildbot-config step (success) 03:57:41 INFO - [mozharness: 2017-03-10 11:57:41.584089Z] Running download-and-extract step. 03:57:41 INFO - Running pre-action listener: _resource_record_pre_action 03:57:41 INFO - Running main action method: download_and_extract 03:57:41 INFO - mkdir: /builds/slave/test/build/tests 03:57:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:57:41 INFO - trying https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 03:57:41 INFO - Downloading https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:57:41 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 03:57:42 INFO - Downloaded 1199 bytes. 03:57:42 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 03:57:42 INFO - Using the following test package requirements: 03:57:42 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:57:42 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:57:42 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 03:57:42 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:57:42 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 03:57:42 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:57:42 INFO - u'jsshell-mac.zip'], 03:57:42 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:57:42 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 03:57:42 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 03:57:42 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:57:42 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 03:57:42 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:57:42 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 03:57:42 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:57:42 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 03:57:42 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 03:57:42 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 03:57:42 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 03:57:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:57:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:57:42 INFO - Fetch https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:57:44 INFO - Expected file size: 51786216 03:57:44 INFO - Obtained file size: 51786216 03:58:00 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 03:58:00 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 03:58:00 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 03:58:00 INFO - Fetch https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 03:58:01 INFO - Expected file size: 51786216 03:58:01 INFO - Obtained file size: 51786216 03:58:17 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 03:58:17 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 03:58:17 INFO - Fetch https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 03:58:18 INFO - Expected file size: 14404424 03:58:18 INFO - Obtained file size: 14404424 03:58:19 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:58:19 INFO - trying https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:58:19 INFO - Downloading https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 03:58:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 03:58:22 INFO - Downloaded 74864298 bytes. 03:58:22 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:58:22 INFO - mkdir: /builds/slave/test/properties 03:58:22 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 03:58:22 INFO - Writing to file /builds/slave/test/properties/build_url 03:58:22 INFO - Contents: 03:58:22 INFO - build_url:https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 03:58:23 INFO - Running post-action listener: _resource_record_post_action 03:58:23 INFO - Running post-action listener: set_extra_try_arguments 03:58:23 INFO - [mozharness: 2017-03-10 11:58:23.848376Z] Finished download-and-extract step (success) 03:58:23 INFO - [mozharness: 2017-03-10 11:58:23.848528Z] Running populate-webroot step. 03:58:23 INFO - Running pre-action listener: _resource_record_pre_action 03:58:23 INFO - Running main action method: populate_webroot 03:58:23 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 03:58:23 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 03:58:23 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 03:58:23 INFO - '--tppagecycles', 03:58:23 INFO - '7'], 03:58:23 INFO - 'tests': ['tsvgm']}}, 03:58:23 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 03:58:23 INFO - 'tests': ['tresize', 'tcanvasmark']}, 03:58:23 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 03:58:23 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 03:58:23 INFO - 'tests': ['dromaeo_css', 'kraken']}, 03:58:23 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 03:58:23 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 03:58:23 INFO - 'talos_options': ['--disable-e10s'], 03:58:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:23 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 03:58:23 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 03:58:23 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 03:58:23 INFO - 'talos_options': ['--disable-e10s'], 03:58:23 INFO - 'tests': ['damp', 'tps']}, 03:58:23 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 03:58:23 INFO - 'tests': ['damp', 'tps']}, 03:58:23 INFO - 'g3': {'talos_options': ['--disable-e10s'], 03:58:23 INFO - 'tests': ['dromaeo_dom']}, 03:58:23 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 03:58:23 INFO - 'g4': {'talos_options': ['--disable-e10s'], 03:58:23 INFO - 'tests': ['basic_compositor_video']}, 03:58:23 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 03:58:23 INFO - 'other': {'talos_options': ['--disable-e10s'], 03:58:23 INFO - 'tests': ['a11yr', 03:58:23 INFO - 'ts_paint', 03:58:23 INFO - 'tpaint', 03:58:23 INFO - 'sessionrestore', 03:58:23 INFO - 'sessionrestore_no_auto_restore', 03:58:23 INFO - 'tabpaint']}, 03:58:23 INFO - 'other-e10s': {'tests': ['a11yr', 03:58:23 INFO - 'ts_paint', 03:58:23 INFO - 'tpaint', 03:58:23 INFO - 'sessionrestore', 03:58:23 INFO - 'sessionrestore_no_auto_restore', 03:58:23 INFO - 'tabpaint']}, 03:58:23 INFO - 'other-e10s_l64': {'tests': ['a11yr', 03:58:23 INFO - 'ts_paint', 03:58:23 INFO - 'tpaint', 03:58:23 INFO - 'sessionrestore', 03:58:23 INFO - 'sessionrestore_no_auto_restore', 03:58:23 INFO - 'tabpaint']}, 03:58:23 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 03:58:23 INFO - 'ts_paint', 03:58:23 INFO - 'tpaint', 03:58:23 INFO - 'sessionrestore', 03:58:23 INFO - 'sessionrestore_no_auto_restore', 03:58:23 INFO - 'tabpaint']}, 03:58:23 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 03:58:23 INFO - 'tests': ['a11yr', 03:58:23 INFO - 'ts_paint', 03:58:23 INFO - 'tpaint', 03:58:23 INFO - 'sessionrestore', 03:58:23 INFO - 'sessionrestore_no_auto_restore', 03:58:23 INFO - 'tabpaint']}, 03:58:23 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 03:58:23 INFO - 'tests': ['a11yr', 03:58:23 INFO - 'ts_paint', 03:58:23 INFO - 'tpaint', 03:58:23 INFO - 'sessionrestore', 03:58:23 INFO - 'sessionrestore_no_auto_restore', 03:58:23 INFO - 'tabpaint']}, 03:58:23 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 03:58:23 INFO - 'tests': ['tsvgx', 03:58:23 INFO - 'tsvgr_opacity', 03:58:23 INFO - 'tart', 03:58:23 INFO - 'tscrollx', 03:58:23 INFO - 'cart', 03:58:23 INFO - 'tsvg_static']}, 03:58:23 INFO - 'svgr-e10s': {'tests': ['tsvgx', 03:58:23 INFO - 'tsvgr_opacity', 03:58:23 INFO - 'tart', 03:58:23 INFO - 'tscrollx', 03:58:23 INFO - 'cart', 03:58:23 INFO - 'tsvg_static']}, 03:58:23 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 03:58:23 INFO - 'talos_options': ['--disable-e10s'], 03:58:23 INFO - 'tests': ['tp5o']}, 03:58:23 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 03:58:23 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 03:58:23 INFO - 'talos_options': ['--disable-e10s', 03:58:23 INFO - '--xperf_path', 03:58:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:23 INFO - 'tests': ['tp5n']}, 03:58:23 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 03:58:23 INFO - 'talos_options': ['--xperf_path', 03:58:23 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 03:58:23 INFO - 'tests': ['tp5n']}}, 03:58:23 INFO - 'talos.zip': {'path': '', 03:58:23 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 03:58:23 INFO - Running post-action listener: _resource_record_post_action 03:58:23 INFO - [mozharness: 2017-03-10 11:58:23.867049Z] Finished populate-webroot step (success) 03:58:23 INFO - [mozharness: 2017-03-10 11:58:23.867181Z] Running create-virtualenv step. 03:58:23 INFO - Running pre-action listener: _resource_record_pre_action 03:58:23 INFO - Running main action method: create_virtualenv 03:58:23 INFO - Creating virtualenv /builds/slave/test/build/venv 03:58:23 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:58:23 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 03:58:23 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 03:58:23 INFO - Using real prefix '/tools/python27' 03:58:23 INFO - New python executable in /builds/slave/test/build/venv/bin/python 03:58:24 INFO - Installing distribute.............................................................................................................................................................................................done. 03:58:27 INFO - Installing pip.................done. 03:58:27 INFO - Return code: 0 03:58:27 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 03:58:27 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 03:58:28 INFO - Reading from file tmpfile_stdout 03:58:28 INFO - Output received: 03:58:28 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 03:58:28 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 03:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ca0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ca3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9434da6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a7ed30>, '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 0x1059a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a73be8>, '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.4w2b9tEXuQ/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.tGLSUVM05U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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:58:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 03:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 03:58:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4w2b9tEXuQ/Render', 03:58:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:28 INFO - 'HOME': '/Users/cltbld', 03:58:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:28 INFO - 'LOGNAME': 'cltbld', 03:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:28 INFO - 'MOZ_NO_REMOTE': '1', 03:58:28 INFO - 'NO_EM_RESTART': '1', 03:58:28 INFO - 'PAGER': '/bin/cat', 03:58:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:28 INFO - 'PWD': '/builds/slave/test', 03:58:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:28 INFO - 'SHELL': '/bin/bash', 03:58:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGLSUVM05U/Listeners', 03:58:28 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 03:58:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:28 INFO - 'USER': 'cltbld', 03:58:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:28 INFO - 'XPC_FLAGS': '0x0', 03:58:28 INFO - 'XPC_SERVICE_NAME': '0', 03:58:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:28 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:58:28 INFO - Cleaning up... 03:58:28 INFO - Return code: 0 03:58:28 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 03:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:28 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x105ca0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ca3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9434da6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a7ed30>, '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 0x1059a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a73be8>, '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.4w2b9tEXuQ/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.tGLSUVM05U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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:58:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 03:58:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 03:58:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4w2b9tEXuQ/Render', 03:58:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:28 INFO - 'HOME': '/Users/cltbld', 03:58:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:28 INFO - 'LOGNAME': 'cltbld', 03:58:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:28 INFO - 'MOZ_NO_REMOTE': '1', 03:58:28 INFO - 'NO_EM_RESTART': '1', 03:58:28 INFO - 'PAGER': '/bin/cat', 03:58:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:28 INFO - 'PWD': '/builds/slave/test', 03:58:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:28 INFO - 'SHELL': '/bin/bash', 03:58:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGLSUVM05U/Listeners', 03:58:28 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 03:58:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:28 INFO - 'USER': 'cltbld', 03:58:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:28 INFO - 'XPC_FLAGS': '0x0', 03:58:28 INFO - 'XPC_SERVICE_NAME': '0', 03:58:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:28 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:28 INFO - Downloading/unpacking psutil>=3.1.1 03:58: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:58: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:58: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:58: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:58: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:58: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:58:31 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 03:58:31 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:31 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:31 INFO - Installing collected packages: psutil 03:58:31 INFO - Running setup.py install for psutil 03:58:32 INFO - building 'psutil._psutil_osx' extension 03:58:32 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:58:32 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:58:32 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:58:32 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:58:32 INFO - building 'psutil._psutil_posix' extension 03:58:32 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:58:32 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 03:58:32 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 03:58:32 INFO - ^ 03:58:32 INFO - 1 warning generated. 03:58:32 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:58:33 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 03:58:33 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 03:58:33 INFO - Successfully installed psutil 03:58:33 INFO - Cleaning up... 03:58:33 INFO - Return code: 0 03:58:33 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 03:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:33 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 0x105ca0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ca3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9434da6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a7ed30>, '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 0x1059a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a73be8>, '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.4w2b9tEXuQ/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.tGLSUVM05U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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:58:33 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:58:33 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:58:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4w2b9tEXuQ/Render', 03:58:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:33 INFO - 'HOME': '/Users/cltbld', 03:58:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:33 INFO - 'LOGNAME': 'cltbld', 03:58:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:33 INFO - 'MOZ_NO_REMOTE': '1', 03:58:33 INFO - 'NO_EM_RESTART': '1', 03:58:33 INFO - 'PAGER': '/bin/cat', 03:58:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:33 INFO - 'PWD': '/builds/slave/test', 03:58:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:33 INFO - 'SHELL': '/bin/bash', 03:58:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGLSUVM05U/Listeners', 03:58:33 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 03:58:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:33 INFO - 'USER': 'cltbld', 03:58:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:33 INFO - 'XPC_FLAGS': '0x0', 03:58:33 INFO - 'XPC_SERVICE_NAME': '0', 03:58:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:34 INFO - Downloading/unpacking mozsystemmonitor==0.3 03:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:37 INFO - Downloading mozsystemmonitor-0.3.tar.gz 03:58:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 03:58:37 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 03:58:37 INFO - Installing collected packages: mozsystemmonitor 03:58:37 INFO - Running setup.py install for mozsystemmonitor 03:58:37 INFO - Successfully installed mozsystemmonitor 03:58:37 INFO - Cleaning up... 03:58:37 INFO - Return code: 0 03:58:37 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 03:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ca0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ca3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9434da6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a7ed30>, '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 0x1059a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a73be8>, '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.4w2b9tEXuQ/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.tGLSUVM05U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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:58:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 03:58:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 03:58:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4w2b9tEXuQ/Render', 03:58:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:37 INFO - 'HOME': '/Users/cltbld', 03:58:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:37 INFO - 'LOGNAME': 'cltbld', 03:58:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:37 INFO - 'MOZ_NO_REMOTE': '1', 03:58:37 INFO - 'NO_EM_RESTART': '1', 03:58:37 INFO - 'PAGER': '/bin/cat', 03:58:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:37 INFO - 'PWD': '/builds/slave/test', 03:58:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:37 INFO - 'SHELL': '/bin/bash', 03:58:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGLSUVM05U/Listeners', 03:58:37 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 03:58:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:37 INFO - 'USER': 'cltbld', 03:58:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:37 INFO - 'XPC_FLAGS': '0x0', 03:58:37 INFO - 'XPC_SERVICE_NAME': '0', 03:58:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:37 INFO - Downloading/unpacking jsonschema==2.5.1 03:58:37 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:58:37 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:58:37 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:58:37 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:58:37 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:58:37 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:58:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 03:58:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 03:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:40 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:40 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:40 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:40 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:40 INFO - Downloading functools32-3.2.3-2.tar.gz 03:58:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 03:58:40 INFO - warning: no files found matching '*.txt' 03:58:40 INFO - no previously-included directories found matching 'build' 03:58:40 INFO - no previously-included directories found matching 'dist' 03:58:40 INFO - no previously-included directories found matching '.git*' 03:58:40 INFO - Installing collected packages: jsonschema, functools32 03:58:40 INFO - Running setup.py install for functools32 03:58:41 INFO - warning: no files found matching '*.txt' 03:58:41 INFO - no previously-included directories found matching 'build' 03:58:41 INFO - no previously-included directories found matching 'dist' 03:58:41 INFO - no previously-included directories found matching '.git*' 03:58:41 INFO - Successfully installed jsonschema functools32 03:58:41 INFO - Cleaning up... 03:58:41 INFO - Return code: 0 03:58:41 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 03:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ca0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ca3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9434da6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a7ed30>, '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 0x1059a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a73be8>, '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.4w2b9tEXuQ/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.tGLSUVM05U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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:58:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 03:58:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 03:58:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4w2b9tEXuQ/Render', 03:58:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:41 INFO - 'HOME': '/Users/cltbld', 03:58:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:41 INFO - 'LOGNAME': 'cltbld', 03:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:41 INFO - 'MOZ_NO_REMOTE': '1', 03:58:41 INFO - 'NO_EM_RESTART': '1', 03:58:41 INFO - 'PAGER': '/bin/cat', 03:58:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:41 INFO - 'PWD': '/builds/slave/test', 03:58:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:41 INFO - 'SHELL': '/bin/bash', 03:58:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGLSUVM05U/Listeners', 03:58:41 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 03:58:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:41 INFO - 'USER': 'cltbld', 03:58:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:41 INFO - 'XPC_FLAGS': '0x0', 03:58:41 INFO - 'XPC_SERVICE_NAME': '0', 03:58:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:41 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 03:58:41 INFO - Cleaning up... 03:58:41 INFO - Return code: 0 03:58:41 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 03:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ca0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ca3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9434da6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a7ed30>, '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 0x1059a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a73be8>, '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.4w2b9tEXuQ/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.tGLSUVM05U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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:58:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 03:58:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 03:58:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4w2b9tEXuQ/Render', 03:58:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:41 INFO - 'HOME': '/Users/cltbld', 03:58:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:41 INFO - 'LOGNAME': 'cltbld', 03:58:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:41 INFO - 'MOZ_NO_REMOTE': '1', 03:58:41 INFO - 'NO_EM_RESTART': '1', 03:58:41 INFO - 'PAGER': '/bin/cat', 03:58:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:41 INFO - 'PWD': '/builds/slave/test', 03:58:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:41 INFO - 'SHELL': '/bin/bash', 03:58:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGLSUVM05U/Listeners', 03:58:41 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 03:58:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:41 INFO - 'USER': 'cltbld', 03:58:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:41 INFO - 'XPC_FLAGS': '0x0', 03:58:41 INFO - 'XPC_SERVICE_NAME': '0', 03:58:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:41 INFO - Downloading/unpacking blobuploader==1.2.4 03:58:41 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:58:41 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:58:41 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:58:41 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:58:41 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:58:41 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:58:44 INFO - Downloading blobuploader-1.2.4.tar.gz 03:58:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 03:58:44 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 03:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:44 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 03:58:45 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 03:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:45 INFO - Downloading docopt-0.6.1.tar.gz 03:58:45 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 03:58:45 INFO - Installing collected packages: blobuploader, requests, docopt 03:58:45 INFO - Running setup.py install for blobuploader 03:58:45 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 03:58:45 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 03:58:45 INFO - Running setup.py install for requests 03:58:46 INFO - Running setup.py install for docopt 03:58:46 INFO - Successfully installed blobuploader requests docopt 03:58:46 INFO - Cleaning up... 03:58:46 INFO - Return code: 0 03:58:46 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:46 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:46 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ca0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ca3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9434da6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a7ed30>, '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 0x1059a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a73be8>, '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.4w2b9tEXuQ/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.tGLSUVM05U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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:58:46 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:58:46 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:58:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4w2b9tEXuQ/Render', 03:58:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:46 INFO - 'HOME': '/Users/cltbld', 03:58:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:46 INFO - 'LOGNAME': 'cltbld', 03:58:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:46 INFO - 'MOZ_NO_REMOTE': '1', 03:58:46 INFO - 'NO_EM_RESTART': '1', 03:58:46 INFO - 'PAGER': '/bin/cat', 03:58:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:46 INFO - 'PWD': '/builds/slave/test', 03:58:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:46 INFO - 'SHELL': '/bin/bash', 03:58:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGLSUVM05U/Listeners', 03:58:46 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 03:58:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:46 INFO - 'USER': 'cltbld', 03:58:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:46 INFO - 'XPC_FLAGS': '0x0', 03:58:46 INFO - 'XPC_SERVICE_NAME': '0', 03:58:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:58:46 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-hBGRWt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:58:46 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-yWqtur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:58:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:58:46 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-1uXAU1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:58:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-C4yRf2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:58:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-NguTwg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:58:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-KNDDmP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:58:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-o_gFSB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:58:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-dStQDi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:58:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-pJUwon-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:58:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-UTSeS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:58:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-L_wy1f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:58:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-00CWRa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:58:47 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:58:47 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-BMs_1a-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:58:48 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-VyuJrz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:48 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-6BeB5f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:58:48 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-KkioVb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:58:48 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:58:48 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-G5F_o3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:58:48 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 03:58:48 INFO - Running setup.py install for manifestparser 03:58:48 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 03:58:48 INFO - Running setup.py install for mozcrash 03:58:48 INFO - Running setup.py install for mozdebug 03:58:48 INFO - Running setup.py install for mozdevice 03:58:49 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 03:58:49 INFO - Installing dm script to /builds/slave/test/build/venv/bin 03:58:49 INFO - Running setup.py install for mozfile 03:58:49 INFO - Running setup.py install for mozhttpd 03:58:49 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 03:58:49 INFO - Running setup.py install for mozinfo 03:58:49 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 03:58:49 INFO - Running setup.py install for mozInstall 03:58:49 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 03:58:49 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 03:58:49 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 03:58:49 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 03:58:49 INFO - Running setup.py install for mozleak 03:58:49 INFO - Running setup.py install for mozlog 03:58:49 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 03:58:50 INFO - Running setup.py install for moznetwork 03:58:50 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 03:58:50 INFO - Running setup.py install for mozprocess 03:58:50 INFO - Running setup.py install for mozprofile 03:58:50 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 03:58:50 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 03:58:50 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 03:58:50 INFO - Running setup.py install for mozrunner 03:58:50 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 03:58:50 INFO - Running setup.py install for mozscreenshot 03:58:50 INFO - Running setup.py install for moztest 03:58:50 INFO - Running setup.py install for mozversion 03:58:51 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 03:58:51 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 03:58:51 INFO - Cleaning up... 03:58:51 INFO - Return code: 0 03:58:51 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ca0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ca3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9434da6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a7ed30>, '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 0x1059a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a73be8>, '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.4w2b9tEXuQ/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.tGLSUVM05U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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:58:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 03:58:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:58:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4w2b9tEXuQ/Render', 03:58:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:51 INFO - 'HOME': '/Users/cltbld', 03:58:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:51 INFO - 'LOGNAME': 'cltbld', 03:58:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:51 INFO - 'MOZ_NO_REMOTE': '1', 03:58:51 INFO - 'NO_EM_RESTART': '1', 03:58:51 INFO - 'PAGER': '/bin/cat', 03:58:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:51 INFO - 'PWD': '/builds/slave/test', 03:58:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:51 INFO - 'SHELL': '/bin/bash', 03:58:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGLSUVM05U/Listeners', 03:58:51 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 03:58:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:51 INFO - 'USER': 'cltbld', 03:58:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:51 INFO - 'XPC_FLAGS': '0x0', 03:58:51 INFO - 'XPC_SERVICE_NAME': '0', 03:58:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 03:58:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-240DVr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 03:58:51 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 03:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 03:58:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-l_ZN_N-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 03:58:51 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:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 03:58:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-jTd674-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 03:58:51 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:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 03:58:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-yG5xsB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 03:58:51 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:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 03:58:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-pE7aKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 03:58:51 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:58:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 03:58:51 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-SyaQok-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 03:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 03:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 03:58:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-NTqqlQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 03:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 03:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 03:58:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-JDMsVf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 03:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 03:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 03:58:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-QL8KF6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 03:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 03:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 03:58:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-84tkHO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 03:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 03:58:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-cel1eb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 03:58:52 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 03:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 03:58:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-BxliJP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 03:58:52 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:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 03:58:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-ezLObl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 03:58:52 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:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 03:58:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-_iuU94-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 03:58:52 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:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-EgsWUW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 03:58:52 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:58:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 03:58:52 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-ApEzaA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 03:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 03:58:53 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 03:58:53 INFO - Running setup.py (path:/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/pip-oBsFn0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 03:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 03:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 03:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 03:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:58:53 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 03:58:53 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 03:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 03:58:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 03:58:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 03:58:55 INFO - Downloading blessings-1.6.tar.gz 03:58:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 03:58:55 INFO - Installing collected packages: blessings 03:58:55 INFO - Running setup.py install for blessings 03:58:56 INFO - Successfully installed blessings 03:58:56 INFO - Cleaning up... 03:58:56 INFO - Return code: 0 03:58:56 INFO - Done creating virtualenv /builds/slave/test/build/venv. 03:58:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:58:56 INFO - Reading from file tmpfile_stdout 03:58:56 INFO - Current package versions: 03:58:56 INFO - blessings == 1.6 03:58:56 INFO - blobuploader == 1.2.4 03:58:56 INFO - docopt == 0.6.1 03:58:56 INFO - functools32 == 3.2.3-2 03:58:56 INFO - jsonschema == 2.5.1 03:58:56 INFO - manifestparser == 1.1 03:58:56 INFO - mozInstall == 1.12 03:58:56 INFO - mozcrash == 1.0 03:58:56 INFO - mozdebug == 0.1 03:58:56 INFO - mozdevice == 0.49 03:58:56 INFO - mozfile == 1.2 03:58:56 INFO - mozhttpd == 0.7 03:58:56 INFO - mozinfo == 0.9 03:58:56 INFO - mozleak == 0.1 03:58:56 INFO - mozlog == 3.4 03:58:56 INFO - moznetwork == 0.27 03:58:56 INFO - mozprocess == 0.25 03:58:56 INFO - mozprofile == 0.28 03:58:56 INFO - mozrunner == 6.13 03:58:56 INFO - mozscreenshot == 0.1 03:58:56 INFO - mozsystemmonitor == 0.3 03:58:56 INFO - moztest == 0.8 03:58:56 INFO - mozversion == 1.4 03:58:56 INFO - psutil == 3.1.1 03:58:56 INFO - requests == 1.2.3 03:58:56 INFO - wsgiref == 0.1.2 03:58:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 03:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x105ca0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ca3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9434da6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a7ed30>, '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 0x1059a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a73be8>, '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.4w2b9tEXuQ/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.tGLSUVM05U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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:58:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 03:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 03:58:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4w2b9tEXuQ/Render', 03:58:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:56 INFO - 'HOME': '/Users/cltbld', 03:58:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:56 INFO - 'LOGNAME': 'cltbld', 03:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:56 INFO - 'MOZ_NO_REMOTE': '1', 03:58:56 INFO - 'NO_EM_RESTART': '1', 03:58:56 INFO - 'PAGER': '/bin/cat', 03:58:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:56 INFO - 'PWD': '/builds/slave/test', 03:58:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:56 INFO - 'SHELL': '/bin/bash', 03:58:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGLSUVM05U/Listeners', 03:58:56 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 03:58:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:56 INFO - 'USER': 'cltbld', 03:58:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:56 INFO - 'XPC_FLAGS': '0x0', 03:58:56 INFO - 'XPC_SERVICE_NAME': '0', 03:58:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:56 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:58:56 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:58:56 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:58:56 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:58:56 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:58:56 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:58:56 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:58:56 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:58:56 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:58:56 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:58:56 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:58:56 INFO - Cleaning up... 03:58:56 INFO - Return code: 0 03:58:56 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 03:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 03:58:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 03:58:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 03:58:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 03:58:56 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 0x105ca0b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105ca3768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb9434da6d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x105a7ed30>, '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 0x1059a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a73be8>, '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.4w2b9tEXuQ/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.tGLSUVM05U/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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:58:56 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:58:56 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:58:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4w2b9tEXuQ/Render', 03:58:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:58:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:58:56 INFO - 'HOME': '/Users/cltbld', 03:58:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:58:56 INFO - 'LOGNAME': 'cltbld', 03:58:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:58:56 INFO - 'MOZ_NO_REMOTE': '1', 03:58:56 INFO - 'NO_EM_RESTART': '1', 03:58:56 INFO - 'PAGER': '/bin/cat', 03:58:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:58:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:58:56 INFO - 'PWD': '/builds/slave/test', 03:58:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:58:56 INFO - 'SHELL': '/bin/bash', 03:58:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGLSUVM05U/Listeners', 03:58:56 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 03:58:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:58:56 INFO - 'USER': 'cltbld', 03:58:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:58:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:58:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:58:56 INFO - 'XPC_FLAGS': '0x0', 03:58:56 INFO - 'XPC_SERVICE_NAME': '0', 03:58:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:58:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 03:58:56 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 03:58:56 INFO - Cleaning up... 03:58:56 INFO - Return code: 0 03:58:56 INFO - Running post-action listener: _resource_record_post_action 03:58:56 INFO - Running post-action listener: _start_resource_monitoring 03:58:56 INFO - Starting resource monitoring. 03:58:56 INFO - [mozharness: 2017-03-10 11:58:56.982712Z] Finished create-virtualenv step (success) 03:58:56 INFO - [mozharness: 2017-03-10 11:58:56.983660Z] Running install step. 03:58:56 INFO - Running pre-action listener: _resource_record_pre_action 03:58:56 INFO - Running main action method: install 03:58:56 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 03:58:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 03:58:57 INFO - Reading from file tmpfile_stdout 03:58:57 INFO - Detecting whether we're running mozinstall >=1.0... 03:58:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 03:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 03:58:57 INFO - Reading from file tmpfile_stdout 03:58:57 INFO - Output received: 03:58:57 INFO - Usage: mozinstall [options] installer 03:58:57 INFO - Options: 03:58:57 INFO - -h, --help show this help message and exit 03:58:57 INFO - -d DEST, --destination=DEST 03:58:57 INFO - Directory to install application into. [default: 03:58:57 INFO - "/builds/slave/test"] 03:58:57 INFO - --app=APP Application being installed. [default: firefox] 03:58:57 INFO - mkdir: /builds/slave/test/build/application 03:58:57 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 03:58:57 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 03:59:17 INFO - Reading from file tmpfile_stdout 03:59:17 INFO - Output received: 03:59:17 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 03:59:17 INFO - Running post-action listener: _resource_record_post_action 03:59:17 INFO - [mozharness: 2017-03-10 11:59:17.407726Z] Finished install step (success) 03:59:17 INFO - [mozharness: 2017-03-10 11:59:17.407865Z] Running run-tests step. 03:59:17 INFO - Running pre-action listener: _resource_record_pre_action 03:59:17 INFO - Running main action method: run_tests 03:59:17 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 03:59:17 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 03:59:17 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 03:59:17 INFO - 2017-03-10 03:59:17.422 screenresolution[1627:7332] starting screenresolution argv=screenresolution get 03:59:17 INFO - 2017-03-10 03:59:17.425 screenresolution[1627:7332] Display 0: 1600x1200x32@60 03:59:17 INFO - 2017-03-10 03:59:17.431 screenresolution[1628:7335] starting screenresolution argv=screenresolution list 03:59:17 INFO - Available Modes on Display 0 03:59:17 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 03:59:17 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 03:59:17 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 03:59:17 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 03:59:17 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 03:59:17 INFO - Intel Iris: 03:59:17 INFO - Chipset Model: Intel Iris 03:59:17 INFO - Type: GPU 03:59:17 INFO - Bus: Built-In 03:59:17 INFO - VRAM (Dynamic, Max): 1536 MB 03:59:17 INFO - Vendor: Intel (0x8086) 03:59:17 INFO - Device ID: 0x0a2e 03:59:17 INFO - Revision ID: 0x0009 03:59:17 INFO - Displays: 03:59:17 INFO - Display: 03:59:17 INFO - Resolution: 1600 x 1200 @ 60 Hz 03:59:17 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 03:59:17 INFO - Display Serial Number: 1600x1200 60 03:59:17 INFO - Main Display: Yes 03:59:17 INFO - Mirror: Off 03:59:17 INFO - Online: Yes 03:59:17 INFO - Rotation: Supported 03:59:17 INFO - Return code: 0 03:59:17 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 03:59:17 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 03:59:17 INFO - Python 2.7.3 03:59:17 INFO - Return code: 0 03:59:17 INFO - grabbing minidump binary from tooltool 03:59:17 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:59:17 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 0x105a7ed30>, '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 0x1059a5db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x105a73be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 03:59:17 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:59:17 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:59:17 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:59:17 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 03:59:17 INFO - Return code: 0 03:59:17 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 03:59:17 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 03:59:17 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 03:59:17 INFO - ENV: RUST_BACKTRACE is now 1 03:59:17 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 03:59:17 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 03:59:17 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/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0325', '--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:59:17 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/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0325 --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:59:17 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.4w2b9tEXuQ/Render', 03:59:17 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 03:59:17 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 03:59:17 INFO - 'HOME': '/Users/cltbld', 03:59:17 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 03:59:17 INFO - 'LOGNAME': 'cltbld', 03:59:17 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 03:59:17 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 03:59:17 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 03:59:17 INFO - 'MOZ_NO_REMOTE': '1', 03:59:17 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 03:59:17 INFO - 'NO_EM_RESTART': '1', 03:59:17 INFO - 'PAGER': '/bin/cat', 03:59:17 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 03:59:17 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 03:59:17 INFO - 'PWD': '/builds/slave/test', 03:59:17 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 03:59:17 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 03:59:17 INFO - 'RUST_BACKTRACE': '1', 03:59:17 INFO - 'SHELL': '/bin/bash', 03:59:17 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tGLSUVM05U/Listeners', 03:59:17 INFO - 'TMPDIR': '/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/', 03:59:17 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 03:59:17 INFO - 'USER': 'cltbld', 03:59:17 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 03:59:17 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 03:59:17 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 03:59:17 INFO - 'XPC_FLAGS': '0x0', 03:59:17 INFO - 'XPC_SERVICE_NAME': '0', 03:59:17 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 03:59:17 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/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0325', '--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:59:18 INFO - mozversion application_buildid: 20170310023722 03:59:18 INFO - mozversion application_changeset: e18d3dd20e8d60bb21524e1b6ef4a87288369afe 03:59:18 INFO - mozversion application_display_name: Nightly 03:59:18 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 03:59:18 INFO - mozversion application_name: Firefox 03:59:18 INFO - mozversion application_remotingname: firefox 03:59:18 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 03:59:18 INFO - mozversion application_vendor: Mozilla 03:59:18 INFO - mozversion application_version: 55.0a1 03:59:18 INFO - mozversion platform_buildid: 20170310023722 03:59:18 INFO - mozversion platform_changeset: e18d3dd20e8d60bb21524e1b6ef4a87288369afe 03:59:18 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 03:59:18 INFO - mozversion platform_version: 55.0a1 03:59:18 INFO - using testdate: 1489147158 03:59:18 INFO - actual date: 1489147158 03:59:18 INFO - starting webserver on 'localhost:49237' 03:59:18 INFO - SUITE-START | Running 2 tests 03:59:18 INFO - TEST-START | dromaeo_css 03:59:18 INFO - operating with platform_type : mac_ 03:59:18 INFO - Initialising browser for dromaeo_css test... 03:59:18 INFO - TEST-INFO | started process 1638 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmpmgMt2V/profile http://localhost:49237/getInfo.html) 03:59:20 INFO - PROCESS | 1638 | __metrics Screen width/height:1600/1200 03:59:20 INFO - PROCESS | 1638 | colorDepth:24 03:59:20 INFO - PROCESS | 1638 | Browser inner width/height: 1024/689 03:59:20 INFO - PROCESS | 1638 | __metrics 03:59:20 INFO - PROCESS | 1638 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 03:59:20 INFO - PROCESS | 1638 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 03:59:21 INFO - TEST-INFO | 1638: exit 0 03:59:21 INFO - Browser initialized. 03:59:21 INFO - Running cycle 1/1 for dromaeo_css test... 03:59:21 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmpmgMt2V/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 03:59:33 INFO - PROCESS | 1640 | RSS: Main: 232538112 03:59:33 INFO - PROCESS | 1640 | 04:02:37 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49237/tests/dromaeo/cssquery-ext.html) 04:02:40 INFO - PROCESS | 1640 | RSS: Main: 463585280 04:02:40 INFO - PROCESS | 1640 | 04:04:23 INFO - PROCESS | 1640 | ************************* 04:04:23 INFO - PROCESS | 1640 | A coding exception was thrown and uncaught in a Task. 04:04:23 INFO - PROCESS | 1640 | 04:04:23 ERROR - PROCESS | 1640 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:04:23 INFO - PROCESS | 1640 | Full stack: 04:04:23 INFO - PROCESS | 1640 | ************************* 04:05:43 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-ext.html (next: http://localhost:49237/tests/dromaeo/cssquery-jquery.html) 04:05:44 INFO - PROCESS | 1640 | RSS: Main: 371433472 04:05:44 INFO - PROCESS | 1640 | 04:08:46 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49237/tests/dromaeo/cssquery-mootools.html) 04:08:47 INFO - PROCESS | 1640 | RSS: Main: 355885056 04:08:47 INFO - PROCESS | 1640 | 04:11:50 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49237/tests/dromaeo/cssquery-prototype.html) 04:11:50 INFO - PROCESS | 1640 | RSS: Main: 357523456 04:11:50 INFO - PROCESS | 1640 | 04:14:54 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49237/tests/dromaeo/cssquery-yui.html) 04:14:54 INFO - PROCESS | 1640 | RSS: Main: 341889024 04:14:54 INFO - PROCESS | 1640 | 04:17:58 INFO - PROCESS | 1640 | Cycle 1(1): loaded http://localhost:49237/tests/dromaeo/cssquery-yui.html (next: http://localhost:49237/tests/dromaeo/cssquery-dojo.html) 04:17:58 INFO - PROCESS | 1640 | RSS: Main: 521355264 04:17:58 INFO - PROCESS | 1640 | 04:17:58 INFO - PROCESS | 1640 | __start_tp_report 04:17:58 INFO - PROCESS | 1640 | _x_x_mozilla_page_load 04:17:58 INFO - PROCESS | 1640 | _x_x_mozilla_page_load_details 04:17:58 INFO - PROCESS | 1640 | |i|pagename|runs| 04:17:58 INFO - PROCESS | 1640 | |0;dojo.html;3338.4491558892782;3351.564296641437;3363.075154332558;3379.442392005319;3402.4215883299835;5687.8578035549135;5789.507891829189;5898.7935422260225;5992.370801065891;6015.759369625215;5723.198752174699;5782.450667186621;5783.942160578393;5791.218185544961;5805.854853628651;5219.8434046978555;5222.999999999981;5244.737763111829;5295.761690723907;5298.682079075248;5332.280142180794;5343.706096164709;5345.65253258537;5354.330708661418;5354.571634269249;4411.713238639478;5328.120860058086;5342.0651386007485;5351.7324133793345;5356.143017117262;5294.735263236823;5312.362516498045;5326.467353264681;5332.14685650298;5336.519713225828;5266.0257852297445;5276.445973172838;5279.86800329991;5287.576993840484;5298.046351656701;5936.5547583931375;6006.339302676702;6016.909746353808;6018.217631707894;6024.8493787655225;6342.460890824239;6345.809625711236;6356.364363563653;6365.395287447732;6365.872682546323;6217.2539295284405;6239.875202495925;6279.277883043463;6320.71556779946;6322.936770632281;5129.9230511542355;5846.707664616794;5879.823605291848;6031.185789918392;6091.238595175603;6391.9680401598625;6412.326705695835;6414.647194404352;6416.165898433267;6421.229452465734;6309.652969086745;6309.905351419732;6328.6202827830475;6334.873302533923;6349.206349206349;6205.472534834499;6247.3440288769025;6280.842978925472;6333.809985700436;6333.968330158412;6225.28409232935;6336.8415789604705;6355.586886852339;6361.2048493938255;6367.076773867763;6266.874662506724;6335.176427064452;6337.42963133311;6348.206474190726;6361.713722882481;4989.750512474435;5098.107831129611;5112.718800465936;5113.923291150636;5125.282460455539;4517.75152366623;4534.501204867462;4537;4553.1121431321235;4577.084583083397;5762.4525670061275;5771.913421298684;5775.133729940542;5780.132980052942;5780.306363236355;6336.52476064297;6342.302346741854;6352.936470635234;6353.96823015882;6363.077353783676;4828.155072862235;5710.885782284331;5738.655680659173;5779.711014449261;5783.248177736951;5483.75323110461;5484.012877681976;5508.91736623951;5512.724363781795;5520.171974203901;6295.087212354275;6296.779612713533;6309.589876658002;6314.778982735582;6323.5573509854785;6284.717187726655;6318.936810632019;6339.841503962253;6350.841228969312;6351.587146835441;6401.167848179707;6401.455876250385;6405.423511883952;6416.647084410402;6432.2281326241155;6060.369019565712;6123.160610921377;6282.8429289266305;6283.308836027942;6344.175257216532;6314.242290925118;6322.241331040304;6330.430261276507;6352.936470635234;6356.110144579855;5227.2943152675425;6141.477974372228;6184.721687523982;6239.188905442264;6293.968530157503;6290.685465726604;6296.6851657417865;6302.968485157545;6310.873782524232;6315.810525684236;6160.291566469913;6160.969195153995;6163.19878415803;6165.568410211242;6183.474404675473;4730.526947305242;6060.272767267956;6061.939380606137;6154.876902461836;6279.905801412891;5993.9700301498215;5995.550333725076;6006.549508786946;6014.669193194241;6028.819135425944 04:17:58 INFO - PROCESS | 1640 | |1;ext.html;762.6606160258685;779.2830595851816;831.5925196653642;843.586642545153;850.4599579267164;27040.72959270407;28161.43677126456;28194.718052819466;28200.153995380148;38673;32240.67759322406;38678.61321386785;39282.41076383857;39296.41055384171;39305.01737456565;9088.454692718442;9204.355695101312;9215.493147876865;9233.6306547738;9260.814783704322;7200.963995180043;7336.266373362674;9019.323550733689;9139.68011119611;9141.588628511732;7353.742619008336;7379.151397589266;10402.167826573856;11128.0541154002;11195.104391648649;11027.889721102807;11094.944525277322;11111.222214444992;11123.944380278128;11124.165687573424;10769.461526923622;10840.945795271053;10841.78316433667;10841.891581084166;10845.457727113691;26709.73290267092;27095.729042709518;27841.86079069612;27845.58231626527;37655.870323890056;3208.2781374190854;3304.9173770655684;3805.315043292206;3982.4623675803687;3988.805449873523;27482.587761183597;27685;27819;28027;28188.577171342447;2789.205076553193;3073.523603841386;3149.434843715988;3184.331290429013;3265.4938484534937;322756;324198;324236;324409.37795310875;325311.373443136;49562.0087598246;49594.752026240356;49629;49634.75182624064;49828.75085624549;34515.13712157216;42807.14385712268;44512.887177820165;45400.54599453963;45515.54484455113;12698.42857071434;12784.424700888483;12789.296588687712;14143.717125657635;14376.921730870226;11849.703757405961;11865.406729663482;11895.286282823059;11908.92819646236;11926.642200733992;12189.390530473442;12235.082368822374;12243.32661703615;12254;12267.57063502773;4680.378887814756;5299.973500132474;5310.468953104659;5317.8936421271355;5322.201669749491;1097.5061222449929;1112.9760620229408;1125.2404626876826;1139.4986206069302;1153.4643637085633;25291.49417011686;25656.358591035372;25709.228723138334;25854;25861.35346616312;1095.9259925273277;1131.4286285425808;1132.671525257666;1134.4157758754247;1191.891540867002;12129.939350303368;12295.32375719326;13365.33173341329;13451.932740336235;13471.663208419868;409010;442494;505113;515098;517983;56696;57373;57438.42561574414;60281.69859150676;60405.39594604086;1435.5047508609514;1470.7793830925448;1471.2423102102425;1483.792269082351;1485.970280594382;28941;29018.56472152877;29049.564256536592;29890;29905.70094299029;39665.80167099146;46204;46297.76851115723;46357.30464042975;46368.536314636425;460559;461469;464453;466044;466886;34334.65665343314;34704.479432809036;35030.64969350274;35112.47331290084;35157.648423515435;34185.145371365914;34944.951651450494;36651.633483664824;43464;43910.34134487921;25733.618587989153;31830.885918992724;35215.47176792401;36562.45156322604;37121.628783711814;35063.47404788879;35267.11832204215;35320.29359412746;36565.08587285339;36675.816620916725;35987;36006.8199659;36278.27443451063;37091.25817483689;38464.03839904025;25962.87018564895;29913.102606921828;32220;32284.677153228167;32610.021699349058;23865.880670596536;23996.760032399452;24166.637500437155;24379.26862194137;24430.511389772462 04:17:58 INFO - PROCESS | 1640 | |2;jquery.html;381.1519369403077;393.2567447524178;411.22689344033205;419.3248869320395;443.14030780286265;12583.748325033504;21260;21775.673364899518;22687;22806.65790013151;20907.37277881662;21495.892520537374;21695.891520542416;21737.782622173774;22274.554508909852;6474.611523308617;6520.67396630169;6640.800775976729;6713.194416670007;6724.327567243286;4122;6507.6420796856155;6623.370779775913;6683.665816709169;6684.431823295025;4284.443022407083;4324.675649326313;4371.956280437187;4439.4672639283335;7629.122650895135;7071.1868135164605;7661.042369703787;7715.382769378492;7715.652795624211;7733.767986960372;7407.444441666843;7489.700411983514;7491.363234125106;7502.774916752506;7508.061492313461;19105.14026868794;21608.35174944754;25477.872610637012;26357.077502287328;26586.734132658617;2928.297208669925;2964.659064207622;2982.7762917781038;3005.173577266269;3021.743151832097;14514.709705805824;15329.693406131815;15378.384864605403;15673.529794106194;16419.83580164195;1909.3699079303935;1948.7466629338237;1962.6369121712387;1965.4693232827199;1979.1291831594197;137808;149566.79115484012;151331;159858.4014159855;163941.54087688815;14480.637984050483;20698;20895.37313880586;21125.68311475329;21479;29443.411131777244;29480.852595736884;31921.042368728977;33451.66548334534;34707.78522751691;9919.305648604528;10485.37087774736;10503.159747220205;10521.26351155427;10679.359238445719;7006.579605223703;8449;8453.196946290092;8657.264132548804;8676.1323867614;8691.826163476822;9941.558474021227;10102.949485252673;10150.4623844039;10318.48407579633;3566.28674265148;4118.062392473951;4148.315527937917;4154.833806647761;4180.393842892824;859.3125499600295;872.8167084912112;886.6409104312763;890.9153630405101;905.7690288976269;19509.60980780405;20880.79119208819;21222.045007974677;21739.565208695738;22090.44773880634;878.8882064188806;902.5306840442933;921.3642586615214;928.6239073175375;943.193569498083;10331.741706457398;10906.236563440483;11392.165834443944;11553.075753939833;11556.94221528887;611323;704432;716475;716735;719188;108753;143259.28370358082;143977.28011359877;146945;147601.26199368935;1018.9082982531608;1231.2304809494067;1274.7641686288066;1276.6999755057554;1280.155097635556;20258.290959816335;20713.585728285652;20860.061297241966;20889;20916.895415522824;55576.16635750548;62715.6864215676;65093.537840080484;65240;66259.01222963318;90433;91356;91511.62732558884;91705;92410;11159.832602511131;11770.76458470843;11958.64124076279;12112.333821639895;12122.333271670142;11634.360110193682;12011.339376334385;12135.211211271238;13470.865291346961;13875.306234688427;7474.738384156529;11425;11582.203757117706;11740.41297935117;11831.46758395857;11511.136664750346;11609.593664221711;11658;11876.871697188753;11898.167128300936;11507.021903138328;11884.909923420146;11964.863337982877;12042.578509752117;12075.456604452997;10603.727552693417;11540.24988375753;11712.824307635563;11945.566532015866;12087.758244834878;11273.492692828679;11616.651500455;11837.940810295893;11859.16985810985;12006.879931200576 04:17:58 INFO - PROCESS | 1640 | |3;mootools.html;1544.3282172255076;1557.4471062772716;1588.2138341520947;1589.6105454163724;1596.7684685720567;10484.580616775329;11100.167487438433;11104.44477776111;11115.11079113672;11134.33194008358;9758.560864761084;10640.78718425631;10812.72968175796;10813.18901082418;10813.296675831043;2302.20573902004;2337.812974961999;2343.9179628713;2344.531093781242;2348.3542025942916;2276.84062115652;2314.259436980167;2317.142657216832;2318.9652155217686;2320.8027317678016;2271.7273927128767;2291.0263138166297;2295.414669259345;2309.734380546242;2311.9884400577976;1946.4160751774482;2242.551489702066;2267.7051983242072;2269.761675024115;2271.5116250006245;2224.4883676754275;2279.9658005129936;2283.0525331987205;2284.326123793485;2286.439822243561;10672.359658420442;10777.191710621735;10784.73038174044;10792.136629069655;10792.352458852494;5570.387257401682;5729.398413166599;5744.798932037401;5751.798687045934;5763.596548241625;3272.934541309184;3368.5789276340456;3582.9967609069504;3585.4621806728937;3588.0671025533547;1044.639599338227;1184.7430644621923;1196.2882085159317;1200.9699757506046;1213.5691829400612;13180.86819131806;13598.660033499242;13913.791293130713;14680.55958321252;14691.55925322242;4417.160739459557;4583.656225783079;4597.126545956257;4607.838725644587;4620.353150558924;11143.72140696489;11160.386178760245;11170.329780213213;11183.552657893755;11202.495887685074;4775.6418268629295;4935.3090567320605;5542.86142846424;5545.334559852843;5548.917960997647;4900.681455705368;5090.821821236239;5153.304303918998;5157.896842063138;5159.380874295109;3558.466230065459;3721.832517536717;3757.6242375762204;3794.2411517696573;3810.9809450952566;1009.9697009089739;1016.2378216337746;1023.2070145637042;1031.3138019338435;1033.9327943683636;882.2148288023664;909.1499448016126;913.7441516375426;940.4404280145927;943.2642538819595;6329.019002054597;6408.775692850728;6563.442107420828;6620.337966203341;6729.966350168218;941.3457646935315;977.7702239973601;994.1003391930315;1012.7215015870547;1019.6584144311738;3984.9003774905277;4081.2449696806184;4203.684723645739;4209.431726716915;4238.17355615652;12702.936485317514;13121.737565248832;13123.278219698008;13141.080124391392;13158.14472059313;12769.425375858109;12811.679708007374;13056.34718264083;13123.60629181126;13124.934375328063;9777.853332200022;9783.315167938175;9838.458884761263;9940;9984.850227246598;6109.175261339662;6153.230846144232;6261.154744109487;6296.087067375113;6335.936640633535;11670.88329116732;12070.879291206975;12072.75854482888;12076.396180191132;12081.093917956012;9709.70870873875;11326.716832078935;11654.592089276835;12057.638270851889;12144.696382590506;7457.664405101675;8266.83466330658;8324.667013319642;8345.290650294794;8433.283170930294;9972.950135249277;9993.10062094415;10118.241131914989;10129.442880641636;10164.440955747505;8328.167183281623;8946.329025322997;8994.865077023718;9041.728748137566;9146.359754817098;7954.522728636301;8603.698870539502;8639.524826134622;8715.956420217859;8893.822123557622;6714.3957043866285;7230.819229519304;7790.961045194737;7795.259450352208;7820.530768153929;5582.33012038558;5616.558254261829;5782.392848750821;5808.82573522795;5856.736446859987;5656.321241451053;5686.346070201815;5931.377205393372;5941.702914854326;6078.513718902565 04:17:58 INFO - PROCESS | 1640 | |4;prototype.html;359.7176216669913;370.6701036077891;376.9849206031759;380.93904975203975;385.2910644414278;4274.743515389075;4698.2482802751565;5020.920502092054;5071.2139618359215;5168.36413429152;4095.3037983542795;4201.600847919451;4925.310456536079;4944.2089265717495;5017.494751574532;3647.74465787395;3904.785236811981;4135.400366946791;4180.979095104521;4204.9487628092975;3863.748856324344;4017.067540695294;4199.543267188683;4215.725977811448;4229.34445160999;3840.347140986025;4116.711830171874;4149.585041495841;4176.248275310443;4196.853110141131;3475.4786781982652;3727.6645101940685;4000.659943904772;4126.823855201284;4136.131412403399;3449.965010496841;3661.9633803662155;3765.9058523536855;3786.2616789726017;3801.733878628497;4587.977060114711;4853.538913803183;4876.7076724667995;4896.216605343164;4913.985266040906;4235.25882970479;4447.911041779146;4524.846164228101;4753.572178503917;4811.8075276988875;4483.663725220622;5009.196689191888;5253.817890974538;5359.356877174725;5447.350275315548;3814.550470821098;4006.358982562776;4225.352112676066;4276.379924910871;4282.571742825724;4100.364443511231;5051.823186188466;5070.188769796851;5403.621746477748;5489.890202196014;3704.24063067076;3799.4680744695765;3839.6544311012144;4261.531231564525;4278.315469524861;3803.5055442792814;4058.898527536835;4059.5331536873045;4286.335617979156;4481.619062379734;4243.469566304212;4399.406080179199;4440.290488162081;4533.206688829442;4805.807767689324;4518.774061296922;5193.766280517386;5229.163333866563;5230.398504172069;5445.646033007842;1437.1879887863324;1498.4081287891222;1506.8342482326934;1511.304799792108;1527.3962339543657;1029.629333439961;1124.3310230413056;1126.3354620773782;1140.9674244808461;1156.6183159557495;4267.551907049778;4601;4740.506740376771;4939;4942.604591632661;4582.931256031162;5023.673461225008;5049.343585333883;5093.439721630618;5417.783288668488;4506.481754598198;4603.447586289667;4867.805287788448;4894.161386395882;4936.914428482199;2468.5926822074516;2478.958837288343;2548.821582489208;2796.832190068562;2866.756325712296;4629.768511574408;5227;5266.947330526646;5750.798722044792;5786.74317016364;4600.930986035212;5109.540141387293;5193.584513238932;5390.568754499709;5686.744096515667;5238.764255608507;5523.210778556803;5591.133374326986;5599.100786811458;5610.4670056344585;4943.011397720398;5055.368078990126;5226.817061402832;5229.764660590206;5536.861578460571;4388.517263100993;5013.674111182761;5157.535821776059;5408.864778380572;5468.2344471773185;5298.602604804578;5669.513249351537;5758.827235182951;5780.913286300624;5796.59423840344;3970.9172259507877;4293.046663767916;4348.695591308705;4394.494633117232;4423.823047078081;4812.951870481251;4951.405831300123;5194.454582268807;5479.863003424946;5502.2296878436255;4512.894340886503;5286.656367336264;5290.761915713879;5293.497117773959;5372.865678358073;4981.203007518924;5103.877147027648;5330.920036199383;5356.732163391737;5364.8122315718765;4335.371371151228;4481.686281960231;4802.663813533159;5171.793128274827;5277.472252774692;4596.862094137181;5229.992754166446;5352.143657014859;5376.0591896418755;5380.300560927054;4446.998850517345;4690.859274221779;4970.950290497049;5236.293100431393;5248.553872920845 04:17:58 INFO - PROCESS | 1640 | |5;yui.html;639.2361128451499;726.8400951790604;728.8702511107784;754.698318496538;759.1876691939624;14664.706705865876;15534;15546.378144874205;15553.377864885419;15568.688626227482;16195.433159839407;17067.658646827054;17102.828971710278;17186.05476698781;17662.38181663642;941.3222479814523;955.8948515663271;961.7066794627635;963.2197919685043;967.2890425537224;965.9082387173207;965.9420434773901;966.0773960867355;966.6809952715587;970.3110791338158;962.7785609309863;1005.5726316315573;1006.7583779892809;1008.0222184481041;1011.3375738891039;984.2126298960874;985.4776968206862;986.6891929042329;987.7185002274317;988.4168340678998;741.0921621014269;742.0464702856857;742.9331360177556;743.2753065760894;745.9403247740167;14984.325705343286;15090.17004064776;15116.924415377853;15260.084394936228;16046.759298610414;14519.20144392058;14781.630459238497;14791.852081479155;14799.40802367904;14837.777433338508;11689.76620467586;11748.823767643493;12071.758564828655;12089.576864809778;12295.877041229563;3600.1899572596217;3706.129059670975;3741.7754934704003;3747.6439738224826;3871.361225397806;111680.4415977923;114731;115041;116025.83974160235;117415.65168696664;11150.832737508943;11462.083033357312;11550.306981581132;11634.185607007428;11785.88214117848;24506.877465612557;24737.752622473905;24773.752262477145;24862.005519779366;25160.245192643884;7833.92166078332;7917.406194535433;7923.418545270217;7985.401094917905;8122.431429799975;4238.660907127422;4272.658187345067;4352.347147927836;4406.294992801137;4411.536788637147;3455;3529.1882866940746;3531.1878267998504;3532.593751718534;3536.8231588420476;624.2508989212963;631.6494345638215;648.3872740260408;657.0669649098196;657.989985372451;596.3529570416147;628.4972022382167;638.2883085359883;688.7727050073464;710.992890071103;9438.38650487716;9715.854262186072;9734;10268.845967310497;10393.9480302598;617.4473845907887;653.8888388973886;676.5399528320789;684.6918886501095;691.1395312835552;4865.927011094836;4879.878003049881;4880.8364308573355;4907.975460122677;4998.675086119463;65488;103248.96751032394;104102.47948760208;106427.40358894622;106877;74360.25639743642;88644.11355886358;89863.20273594491;91667;92923.53538232266;79911;80254.59872700598;81734.59132704299;81951.5902420496;81961;9447.622095116394;9448.244140468609;9449.574769135268;9454.385464944757;9488.667896623585;45887.80514630616;50653.49346506635;52363.21455178099;52783.94432111413;52855.471445286596;63948;65666;67206.66396667986;67694;68293.65853170703;11528.250663706833;11579;11646.88353116458;11788.29229950299;12271.58573615151;12106.213096148722;12480.937595311965;12508.56220032331;12575.308358040029;12631.684207894876;11425.107209763233;11817.99669211325;11844.466998984894;12237.755244894874;12441.066919980856;11537.538498459968;11829.704257393634;12224;12237.877621223673;12389.75220495567;11741.47163377633;11834.763304733684;11977.401129943642;12131.150819442555;12179;9727.221822254343;9909.355891867006;10009.178636104347;10189.949050254701;10725.624603138853;8879.467231966102;9875.160611348116;9886.604535818487;9897;9901.405915645084 04:17:58 INFO - PROCESS | 1640 | __end_tp_report 04:17:58 INFO - PROCESS | 1640 | __start_cc_report 04:17:58 INFO - PROCESS | 1640 | _x_x_mozilla_cycle_collect,2763 04:17:58 INFO - PROCESS | 1640 | __end_cc_report 04:17:58 INFO - PROCESS | 1640 | __startTimestamp1489148278914__endTimestamp 04:17:58 INFO - PROCESS | 1640 | 04:17:58 INFO - PROCESS | 1640 | ------- Summary: start ------- 04:17:58 INFO - PROCESS | 1640 | Number of tests: 6 04:17:58 INFO - PROCESS | 1640 | 04:17:58 INFO - PROCESS | 1640 | [#0] dojo.html Cycles:165 Average:5826.34 Median:6060.37 stddev:668.12 (11.0%) stddev-sans-first:641.03 04:17:58 INFO - PROCESS | 1640 | Values: 3338.4 3351.6 3363.1 3379.4 3402.4 5687.9 5789.5 5898.8 5992.4 6015.8 5723.2 5782.5 5783.9 5791.2 5805.9 5219.8 5223.0 5244.7 5295.8 5298.7 5332.3 5343.7 5345.7 5354.3 5354.6 4411.7 5328.1 5342.1 5351.7 5356.1 5294.7 5312.4 5326.5 5332.1 5336.5 5266.0 5276.4 5279.9 5287.6 5298.0 5936.6 6006.3 6016.9 6018.2 6024.8 6342.5 6345.8 6356.4 6365.4 6365.9 6217.3 6239.9 6279.3 6320.7 6322.9 5129.9 5846.7 5879.8 6031.2 6091.2 6392.0 6412.3 6414.6 6416.2 6421.2 6309.7 6309.9 6328.6 6334.9 6349.2 6205.5 6247.3 6280.8 6333.8 6334.0 6225.3 6336.8 6355.6 6361.2 6367.1 6266.9 6335.2 6337.4 6348.2 6361.7 4989.8 5098.1 5112.7 5113.9 5125.3 4517.8 4534.5 4537.0 4553.1 4577.1 5762.5 5771.9 5775.1 5780.1 5780.3 6336.5 6342.3 6352.9 6354.0 6363.1 4828.2 5710.9 5738.7 5779.7 5783.2 5483.8 5484.0 5508.9 5512.7 5520.2 6295.1 6296.8 6309.6 6314.8 6323.6 6284.7 6318.9 6339.8 6350.8 6351.6 6401.2 6401.5 6405.4 6416.6 6432.2 6060.4 6123.2 6282.8 6283.3 6344.2 6314.2 6322.2 6330.4 6352.9 6356.1 5227.3 6141.5 6184.7 6239.2 6294.0 6290.7 6296.7 6303.0 6310.9 6315.8 6160.3 6161.0 6163.2 6165.6 6183.5 4730.5 6060.3 6061.9 6154.9 6279.9 5994.0 5995.6 6006.5 6014.7 6028.8 04:17:58 INFO - PROCESS | 1640 | 04:17:58 INFO - PROCESS | 1640 | [#1] ext.html Cycles:180 Average:55326.08 Median:324322.69 stddev:113960.57 (35.1%) stddev-sans-first:114206.62 04:17:58 INFO - PROCESS | 1640 | Values: 762.7 779.3 831.6 843.6 850.5 27040.7 28161.4 28194.7 28200.2 38673.0 32240.7 38678.6 39282.4 39296.4 39305.0 9088.5 9204.4 9215.5 9233.6 9260.8 7201.0 7336.3 9019.3 9139.7 9141.6 7353.7 7379.2 10402.2 11128.1 11195.1 11027.9 11094.9 11111.2 11123.9 11124.2 10769.5 10840.9 10841.8 10841.9 10845.5 26709.7 27095.7 27841.9 27845.6 37655.9 3208.3 3304.9 3805.3 3982.5 3988.8 27482.6 27685.0 27819.0 28027.0 28188.6 2789.2 3073.5 3149.4 3184.3 3265.5 322756.0 324198.0 324236.0 324409.4 325311.4 49562.0 49594.8 49629.0 49634.8 49828.8 34515.1 42807.1 44512.9 45400.5 45515.5 12698.4 12784.4 12789.3 14143.7 14376.9 11849.7 11865.4 11895.3 11908.9 11926.6 12189.4 12235.1 12243.3 12254.0 12267.6 4680.4 5300.0 5310.5 5317.9 5322.2 1097.5 1113.0 1125.2 1139.5 1153.5 25291.5 25656.4 25709.2 25854.0 25861.4 1095.9 1131.4 1132.7 1134.4 1191.9 12129.9 12295.3 13365.3 13451.9 13471.7 409010.0 442494.0 505113.0 515098.0 517983.0 56696.0 57373.0 57438.4 60281.7 60405.4 1435.5 1470.8 1471.2 1483.8 1486.0 28941.0 29018.6 29049.6 29890.0 29905.7 39665.8 46204.0 46297.8 46357.3 46368.5 460559.0 461469.0 464453.0 466044.0 466886.0 34334.7 34704.5 35030.6 35112.5 35157.6 34185.1 34945.0 36651.6 43464.0 43910.3 25733.6 31830.9 35215.5 36562.5 37121.6 35063.5 35267.1 35320.3 36565.1 36675.8 35987.0 36006.8 36278.3 37091.3 38464.0 25962.9 29913.1 32220.0 32284.7 32610.0 23865.9 23996.8 24166.6 24379.3 24430.5 04:17:58 INFO - PROCESS | 1640 | 04:17:58 INFO - PROCESS | 1640 | [#2] jquery.html Cycles:180 Average:41116.91 Median:21716.84 stddev:116103.15 (534.6%) stddev-sans-first:116388.56 04:17:58 INFO - PROCESS | 1640 | Values: 381.2 393.3 411.2 419.3 443.1 12583.7 21260.0 21775.7 22687.0 22806.7 20907.4 21495.9 21695.9 21737.8 22274.6 6474.6 6520.7 6640.8 6713.2 6724.3 4122.0 6507.6 6623.4 6683.7 6684.4 4284.4 4324.7 4372.0 4439.5 7629.1 7071.2 7661.0 7715.4 7715.7 7733.8 7407.4 7489.7 7491.4 7502.8 7508.1 19105.1 21608.4 25477.9 26357.1 26586.7 2928.3 2964.7 2982.8 3005.2 3021.7 14514.7 15329.7 15378.4 15673.5 16419.8 1909.4 1948.7 1962.6 1965.5 1979.1 137808.0 149566.8 151331.0 159858.4 163941.5 14480.6 20698.0 20895.4 21125.7 21479.0 29443.4 29480.9 31921.0 33451.7 34707.8 9919.3 10485.4 10503.2 10521.3 10679.4 7006.6 8449.0 8453.2 8657.3 8676.1 8691.8 9941.6 10102.9 10150.5 10318.5 3566.3 4118.1 4148.3 4154.8 4180.4 859.3 872.8 886.6 890.9 905.8 19509.6 20880.8 21222.0 21739.6 22090.4 878.9 902.5 921.4 928.6 943.2 10331.7 10906.2 11392.2 11553.1 11556.9 611323.0 704432.0 716475.0 716735.0 719188.0 108753.0 143259.3 143977.3 146945.0 147601.3 1018.9 1231.2 1274.8 1276.7 1280.2 20258.3 20713.6 20860.1 20889.0 20916.9 55576.2 62715.7 65093.5 65240.0 66259.0 90433.0 91356.0 91511.6 91705.0 92410.0 11159.8 11770.8 11958.6 12112.3 12122.3 11634.4 12011.3 12135.2 13470.9 13875.3 7474.7 11425.0 11582.2 11740.4 11831.5 11511.1 11609.6 11658.0 11876.9 11898.2 11507.0 11884.9 11964.9 12042.6 12075.5 10603.7 11540.2 11712.8 11945.6 12087.8 11273.5 11616.7 11837.9 11859.2 12006.9 04:17:58 INFO - PROCESS | 1640 | 04:17:58 INFO - PROCESS | 1640 | [#3] mootools.html Cycles:180 Average:6482.21 Median:3570.73 stddev:4012.73 (112.4%) stddev-sans-first:4006.83 04:17:58 INFO - PROCESS | 1640 | Values: 1544.3 1557.4 1588.2 1589.6 1596.8 10484.6 11100.2 11104.4 11115.1 11134.3 9758.6 10640.8 10812.7 10813.2 10813.3 2302.2 2337.8 2343.9 2344.5 2348.4 2276.8 2314.3 2317.1 2319.0 2320.8 2271.7 2291.0 2295.4 2309.7 2312.0 1946.4 2242.6 2267.7 2269.8 2271.5 2224.5 2280.0 2283.1 2284.3 2286.4 10672.4 10777.2 10784.7 10792.1 10792.4 5570.4 5729.4 5744.8 5751.8 5763.6 3272.9 3368.6 3583.0 3585.5 3588.1 1044.6 1184.7 1196.3 1201.0 1213.6 13180.9 13598.7 13913.8 14680.6 14691.6 4417.2 4583.7 4597.1 4607.8 4620.4 11143.7 11160.4 11170.3 11183.6 11202.5 4775.6 4935.3 5542.9 5545.3 5548.9 4900.7 5090.8 5153.3 5157.9 5159.4 3558.5 3721.8 3757.6 3794.2 3811.0 1010.0 1016.2 1023.2 1031.3 1033.9 882.2 909.1 913.7 940.4 943.3 6329.0 6408.8 6563.4 6620.3 6730.0 941.3 977.8 994.1 1012.7 1019.7 3984.9 4081.2 4203.7 4209.4 4238.2 12702.9 13121.7 13123.3 13141.1 13158.1 12769.4 12811.7 13056.3 13123.6 13124.9 9777.9 9783.3 9838.5 9940.0 9984.9 6109.2 6153.2 6261.2 6296.1 6335.9 11670.9 12070.9 12072.8 12076.4 12081.1 9709.7 11326.7 11654.6 12057.6 12144.7 7457.7 8266.8 8324.7 8345.3 8433.3 9973.0 9993.1 10118.2 10129.4 10164.4 8328.2 8946.3 8994.9 9041.7 9146.4 7954.5 8603.7 8639.5 8716.0 8893.8 6714.4 7230.8 7791.0 7795.3 7820.5 5582.3 5616.6 5782.4 5808.8 5856.7 5656.3 5686.3 5931.4 5941.7 6078.5 04:17:58 INFO - PROCESS | 1640 | 04:17:58 INFO - PROCESS | 1640 | [#4] prototype.html Cycles:180 Average:4375.44 Median:4616.61 stddev:1219.71 (26.4%) stddev-sans-first:1185.31 04:17:58 INFO - PROCESS | 1640 | Values: 359.7 370.7 377.0 380.9 385.3 4274.7 4698.2 5020.9 5071.2 5168.4 4095.3 4201.6 4925.3 4944.2 5017.5 3647.7 3904.8 4135.4 4181.0 4204.9 3863.7 4017.1 4199.5 4215.7 4229.3 3840.3 4116.7 4149.6 4176.2 4196.9 3475.5 3727.7 4000.7 4126.8 4136.1 3450.0 3662.0 3765.9 3786.3 3801.7 4588.0 4853.5 4876.7 4896.2 4914.0 4235.3 4447.9 4524.8 4753.6 4811.8 4483.7 5009.2 5253.8 5359.4 5447.4 3814.6 4006.4 4225.4 4276.4 4282.6 4100.4 5051.8 5070.2 5403.6 5489.9 3704.2 3799.5 3839.7 4261.5 4278.3 3803.5 4058.9 4059.5 4286.3 4481.6 4243.5 4399.4 4440.3 4533.2 4805.8 4518.8 5193.8 5229.2 5230.4 5445.6 1437.2 1498.4 1506.8 1511.3 1527.4 1029.6 1124.3 1126.3 1141.0 1156.6 4267.6 4601.0 4740.5 4939.0 4942.6 4582.9 5023.7 5049.3 5093.4 5417.8 4506.5 4603.4 4867.8 4894.2 4936.9 2468.6 2479.0 2548.8 2796.8 2866.8 4629.8 5227.0 5266.9 5750.8 5786.7 4600.9 5109.5 5193.6 5390.6 5686.7 5238.8 5523.2 5591.1 5599.1 5610.5 4943.0 5055.4 5226.8 5229.8 5536.9 4388.5 5013.7 5157.5 5408.9 5468.2 5298.6 5669.5 5758.8 5780.9 5796.6 3970.9 4293.0 4348.7 4394.5 4423.8 4813.0 4951.4 5194.5 5479.9 5502.2 4512.9 5286.7 5290.8 5293.5 5372.9 4981.2 5103.9 5330.9 5356.7 5364.8 4335.4 4481.7 4802.7 5171.8 5277.5 4596.9 5230.0 5352.1 5376.1 5380.3 4447.0 4690.9 4971.0 5236.3 5248.6 04:17:58 INFO - PROCESS | 1640 | 04:17:58 INFO - PROCESS | 1640 | [#5] yui.html Cycles:180 Average:20562.37 Median:4379.32 stddev:29966.54 (684.3%) stddev-sans-first:30013.26 04:17:58 INFO - PROCESS | 1640 | Values: 639.2 726.8 728.9 754.7 759.2 14664.7 15534.0 15546.4 15553.4 15568.7 16195.4 17067.7 17102.8 17186.1 17662.4 941.3 955.9 961.7 963.2 967.3 965.9 965.9 966.1 966.7 970.3 962.8 1005.6 1006.8 1008.0 1011.3 984.2 985.5 986.7 987.7 988.4 741.1 742.0 742.9 743.3 745.9 14984.3 15090.2 15116.9 15260.1 16046.8 14519.2 14781.6 14791.9 14799.4 14837.8 11689.8 11748.8 12071.8 12089.6 12295.9 3600.2 3706.1 3741.8 3747.6 3871.4 111680.4 114731.0 115041.0 116025.8 117415.7 11150.8 11462.1 11550.3 11634.2 11785.9 24506.9 24737.8 24773.8 24862.0 25160.2 7833.9 7917.4 7923.4 7985.4 8122.4 4238.7 4272.7 4352.3 4406.3 4411.5 3455.0 3529.2 3531.2 3532.6 3536.8 624.3 631.6 648.4 657.1 658.0 596.4 628.5 638.3 688.8 711.0 9438.4 9715.9 9734.0 10268.8 10393.9 617.4 653.9 676.5 684.7 691.1 4865.9 4879.9 4880.8 4908.0 4998.7 65488.0 103249.0 104102.5 106427.4 106877.0 74360.3 88644.1 89863.2 91667.0 92923.5 79911.0 80254.6 81734.6 81951.6 81961.0 9447.6 9448.2 9449.6 9454.4 9488.7 45887.8 50653.5 52363.2 52783.9 52855.5 63948.0 65666.0 67206.7 67694.0 68293.7 11528.3 11579.0 11646.9 11788.3 12271.6 12106.2 12480.9 12508.6 12575.3 12631.7 11425.1 11818.0 11844.5 12237.8 12441.1 11537.5 11829.7 12224.0 12237.9 12389.8 11741.5 11834.8 11977.4 12131.2 12179.0 9727.2 9909.4 10009.2 10189.9 10725.6 8879.5 9875.2 9886.6 9897.0 9901.4 04:17:58 INFO - PROCESS | 1640 | -------- Summary: end -------- 04:17:58 INFO - PROCESS | 1640 | 04:17:59 INFO - TEST-INFO | 1640: exit 0 04:17:59 INFO - TEST-OK | dromaeo_css | took 1121612ms 04:17:59 INFO - TEST-START | kraken 04:17:59 INFO - operating with platform_type : mac_ 04:17:59 INFO - Initialising browser for kraken test... 04:17:59 INFO - TEST-INFO | started process 1649 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmpoNbvd0/profile http://localhost:49237/getInfo.html) 04:18:02 INFO - PROCESS | 1649 | __metrics Screen width/height:1600/1200 04:18:02 INFO - PROCESS | 1649 | colorDepth:24 04:18:02 INFO - PROCESS | 1649 | Browser inner width/height: 1024/689 04:18:02 INFO - PROCESS | 1649 | __metrics 04:18:02 INFO - PROCESS | 1649 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:18:02 INFO - PROCESS | 1649 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:18:02 INFO - TEST-INFO | 1649: exit 0 04:18:02 INFO - Browser initialized. 04:18:02 INFO - Running cycle 1/1 for kraken test... 04:18:02 INFO - TEST-INFO | started process 1650 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/T/tmpoNbvd0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:18:15 INFO - PROCESS | 1650 | RSS: Main: 232767488 04:18:15 INFO - PROCESS | 1650 | 04:18:18 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection) 04:18:18 INFO - PROCESS | 1650 | RSS: Main: 284483584 04:18:18 INFO - PROCESS | 1650 | 04:18:21 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-dft) 04:18:22 INFO - PROCESS | 1650 | RSS: Main: 286425088 04:18:22 INFO - PROCESS | 1650 | 04:18:25 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-fft) 04:18:26 INFO - PROCESS | 1650 | RSS: Main: 376901632 04:18:26 INFO - PROCESS | 1650 | 04:18:28 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator) 04:18:28 INFO - PROCESS | 1650 | RSS: Main: 280879104 04:18:28 INFO - PROCESS | 1650 | 04:18:30 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:18:31 INFO - PROCESS | 1650 | RSS: Main: 283230208 04:18:31 INFO - PROCESS | 1650 | 04:18:34 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom) 04:18:35 INFO - PROCESS | 1650 | RSS: Main: 324296704 04:18:35 INFO - PROCESS | 1650 | 04:18:38 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate) 04:18:38 INFO - PROCESS | 1650 | RSS: Main: 328634368 04:18:38 INFO - PROCESS | 1650 | 04:18:41 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial) 04:18:42 INFO - PROCESS | 1650 | RSS: Main: 324775936 04:18:42 INFO - PROCESS | 1650 | 04:18:44 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:18:44 INFO - PROCESS | 1650 | RSS: Main: 302706688 04:18:44 INFO - PROCESS | 1650 | 04:18:46 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:18:47 INFO - PROCESS | 1650 | RSS: Main: 308338688 04:18:47 INFO - PROCESS | 1650 | 04:18:49 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:18:50 INFO - PROCESS | 1650 | RSS: Main: 309997568 04:18:50 INFO - PROCESS | 1650 | 04:18:53 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:18:53 INFO - PROCESS | 1650 | RSS: Main: 325963776 04:18:53 INFO - PROCESS | 1650 | 04:18:56 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:18:57 INFO - PROCESS | 1650 | RSS: Main: 320225280 04:18:57 INFO - PROCESS | 1650 | 04:18:59 INFO - PROCESS | 1650 | Cycle 1(1): loaded http://localhost:49237/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49237/tests/kraken/driver.html?testName=ai-astar) 04:18:59 INFO - PROCESS | 1650 | RSS: Main: 364519424 04:18:59 INFO - PROCESS | 1650 | 04:18:59 INFO - PROCESS | 1650 | __start_tp_report 04:18:59 INFO - PROCESS | 1650 | _x_x_mozilla_page_load 04:18:59 INFO - PROCESS | 1650 | _x_x_mozilla_page_load_details 04:18:59 INFO - PROCESS | 1650 | |i|pagename|runs| 04:18:59 INFO - PROCESS | 1650 | |0;ai-astar;114;117;114;116;115;117;115;115;113;118 04:18:59 INFO - PROCESS | 1650 | |1;audio-beat-detection;144;111;110;146;113;109;107;129;128;109 04:18:59 INFO - PROCESS | 1650 | |2;audio-dft;181;183;181;185;184;182;183;180;182;182 04:18:59 INFO - PROCESS | 1650 | |3;audio-fft;82;59;66;103;87;81;61;59;77;60 04:18:59 INFO - PROCESS | 1650 | |4;audio-oscillator;88;71;90;71;70;69;84;70;69;84 04:18:59 INFO - PROCESS | 1650 | |5;imaging-gaussian-blur;86;85;86;93;86;86;86;85;86;85 04:18:59 INFO - PROCESS | 1650 | |6;imaging-darkroom;93;94;93;93;93;101;145;94;94;93 04:18:59 INFO - PROCESS | 1650 | |7;imaging-desaturate;83;84;85;83;86;82;84;86;86;85 04:18:59 INFO - PROCESS | 1650 | |8;json-parse-financial;62;61;60;60;63;64;63;60;64;62 04:18:59 INFO - PROCESS | 1650 | |9;json-stringify-tinderbox;61;53;61;66;62;58;59;60;60;59 04:18:59 INFO - PROCESS | 1650 | |10;stanford-crypto-aes;87;88;85;87;87;87;86;85;86;88 04:18:59 INFO - PROCESS | 1650 | |11;stanford-crypto-ccm;163;141;143;138;138;142;138;141;173;157 04:18:59 INFO - PROCESS | 1650 | |12;stanford-crypto-pbkdf2;174;171;183;225;196;172;173;170;173;180 04:18:59 INFO - PROCESS | 1650 | |13;stanford-crypto-sha256-iterative;67;67;67;66;66;67;66;74;82;82 04:18:59 INFO - PROCESS | 1650 | __end_tp_report 04:18:59 INFO - PROCESS | 1650 | __start_cc_report 04:18:59 INFO - PROCESS | 1650 | _x_x_mozilla_cycle_collect,2109 04:18:59 INFO - PROCESS | 1650 | __end_cc_report 04:18:59 INFO - PROCESS | 1650 | __startTimestamp1489148339637__endTimestamp 04:18:59 INFO - PROCESS | 1650 | 04:18:59 INFO - PROCESS | 1650 | ------- Summary: start ------- 04:18:59 INFO - PROCESS | 1650 | Number of tests: 14 04:18:59 INFO - PROCESS | 1650 | 04:18:59 INFO - PROCESS | 1650 | [#0] ai-astar Cycles:10 Average:115.40 Median:115.50 stddev:1.58 (1.4%) stddev-sans-first:1.59 04:18:59 INFO - PROCESS | 1650 | Values: 114.0 117.0 114.0 116.0 115.0 117.0 115.0 115.0 113.0 118.0 04:18:59 INFO - PROCESS | 1650 | 04:18:59 INFO - PROCESS | 1650 | [#1] audio-beat-detection Cycles:10 Average:120.60 Median:120.50 stddev:15.03 (12.5%) stddev-sans-first:13.35 04:18:59 INFO - PROCESS | 1650 | Values: 144.0 111.0 110.0 146.0 113.0 109.0 107.0 129.0 128.0 109.0 04:18:59 INFO - PROCESS | 1650 | 04:18:59 INFO - PROCESS | 1650 | [#2] audio-dft Cycles:10 Average:182.30 Median:182.50 stddev:1.49 (0.8%) stddev-sans-first:1.51 04:18:59 INFO - PROCESS | 1650 | Values: 181.0 183.0 181.0 185.0 184.0 182.0 183.0 180.0 182.0 182.0 04:18:59 INFO - PROCESS | 1650 | 04:18:59 INFO - PROCESS | 1650 | [#3] audio-fft Cycles:10 Average:73.50 Median:71.50 stddev:14.94 (20.9%) stddev-sans-first:15.53 04:18:59 INFO - PROCESS | 1650 | Values: 82.0 59.0 66.0 103.0 87.0 81.0 61.0 59.0 77.0 60.0 04:18:59 INFO - PROCESS | 1650 | 04:18:59 INFO - PROCESS | 1650 | [#4] audio-oscillator Cycles:10 Average:76.60 Median:77.50 stddev:8.72 (11.3%) stddev-sans-first:8.22 04:18:59 INFO - PROCESS | 1650 | Values: 88.0 71.0 90.0 71.0 70.0 69.0 84.0 70.0 69.0 84.0 04:18:59 INFO - PROCESS | 1650 | 04:18:59 INFO - PROCESS | 1650 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:86.00 stddev:2.37 (2.8%) stddev-sans-first:2.51 04:18:59 INFO - PROCESS | 1650 | Values: 86.0 85.0 86.0 93.0 86.0 86.0 86.0 85.0 86.0 85.0 04:18:59 INFO - PROCESS | 1650 | 04:18:59 INFO - PROCESS | 1650 | [#6] imaging-darkroom Cycles:10 Average:99.30 Median:93.00 stddev:16.24 (17.5%) stddev-sans-first:17.07 04:18:59 INFO - PROCESS | 1650 | Values: 93.0 94.0 93.0 93.0 93.0 101.0 145.0 94.0 94.0 93.0 04:18:59 INFO - PROCESS | 1650 | 04:18:59 INFO - PROCESS | 1650 | [#7] imaging-desaturate Cycles:10 Average:84.40 Median:85.00 stddev:1.43 (1.7%) stddev-sans-first:1.42 04:18:59 INFO - PROCESS | 1650 | Values: 83.0 84.0 85.0 83.0 86.0 82.0 84.0 86.0 86.0 85.0 04:18:59 INFO - PROCESS | 1650 | 04:18:59 INFO - PROCESS | 1650 | [#8] json-parse-financial Cycles:10 Average:61.90 Median:62.50 stddev:1.60 (2.6%) stddev-sans-first:1.69 04:18:59 INFO - PROCESS | 1650 | Values: 62.0 61.0 60.0 60.0 63.0 64.0 63.0 60.0 64.0 62.0 04:18:59 INFO - PROCESS | 1650 | 04:18:59 INFO - PROCESS | 1650 | [#9] json-stringify-tinderbox Cycles:10 Average:59.90 Median:60.50 stddev:3.28 (5.4%) stddev-sans-first:3.46 04:18:59 INFO - PROCESS | 1650 | Values: 61.0 53.0 61.0 66.0 62.0 58.0 59.0 60.0 60.0 59.0 04:18:59 INFO - PROCESS | 1650 | 04:18:59 INFO - PROCESS | 1650 | [#10] stanford-crypto-aes Cycles:10 Average:86.60 Median:87.00 stddev:1.07 (1.2%) stddev-sans-first:1.13 04:18:59 INFO - PROCESS | 1650 | Values: 87.0 88.0 85.0 87.0 87.0 87.0 86.0 85.0 86.0 88.0 04:18:59 INFO - PROCESS | 1650 | 04:18:59 INFO - PROCESS | 1650 | [#11] stanford-crypto-ccm Cycles:10 Average:147.40 Median:142.50 stddev:12.41 (8.7%) stddev-sans-first:11.81 04:18:59 INFO - PROCESS | 1650 | Values: 163.0 141.0 143.0 138.0 138.0 142.0 138.0 141.0 173.0 157.0 04:18:59 INFO - PROCESS | 1650 | 04:18:59 INFO - PROCESS | 1650 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:181.70 Median:177.00 stddev:17.13 (9.7%) stddev-sans-first:17.94 04:18:59 INFO - PROCESS | 1650 | Values: 174.0 171.0 183.0 225.0 196.0 172.0 173.0 170.0 173.0 180.0 04:18:59 INFO - PROCESS | 1650 | 04:18:59 INFO - PROCESS | 1650 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:70.40 Median:67.00 stddev:6.55 (9.8%) stddev-sans-first:6.83 04:18:59 INFO - PROCESS | 1650 | Values: 67.0 67.0 67.0 66.0 66.0 67.0 66.0 74.0 82.0 82.0 04:18:59 INFO - PROCESS | 1650 | -------- Summary: end -------- 04:18:59 INFO - PROCESS | 1650 | 04:19:00 INFO - TEST-INFO | 1650: exit 0 04:19:00 INFO - TEST-OK | kraken | took 60944ms 04:19:00 INFO - SUITE-END | took 1182s 04:19:00 INFO - Completed test suite (00:19:42) 04:19:00 INFO - javascript benchmark 04:19:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7524.254636455949, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3338.4491558892782, 3351.564296641437, 3363.075154332558, 3379.442392005319, 3402.4215883299835, 5687.8578035549135, 5789.507891829189, 5898.7935422260225, 5992.370801065891, 6015.759369625215, 5723.198752174699, 5782.450667186621, 5783.942160578393, 5791.218185544961, 5805.854853628651, 5219.8434046978555, 5222.999999999981, 5244.737763111829, 5295.761690723907, 5298.682079075248, 5332.280142180794, 5343.706096164709, 5345.65253258537, 5354.330708661418, 5354.571634269249, 4411.713238639478, 5328.120860058086, 5342.0651386007485, 5351.7324133793345, 5356.143017117262, 5294.735263236823, 5312.362516498045, 5326.467353264681, 5332.14685650298, 5336.519713225828, 5266.0257852297445, 5276.445973172838, 5279.86800329991, 5287.576993840484, 5298.046351656701, 5936.5547583931375, 6006.339302676702, 6016.909746353808, 6018.217631707894, 6024.8493787655225, 6342.460890824239, 6345.809625711236, 6356.364363563653, 6365.395287447732, 6365.872682546323, 6217.2539295284405, 6239.875202495925, 6279.277883043463, 6320.71556779946, 6322.936770632281, 5129.9230511542355, 5846.707664616794, 5879.823605291848, 6031.185789918392, 6091.238595175603, 6391.9680401598625, 6412.326705695835, 6414.647194404352, 6416.165898433267, 6421.229452465734, 6309.652969086745, 6309.905351419732, 6328.6202827830475, 6334.873302533923, 6349.206349206349, 6205.472534834499, 6247.3440288769025, 6280.842978925472, 6333.809985700436, 6333.968330158412, 6225.28409232935, 6336.8415789604705, 6355.586886852339, 6361.2048493938255, 6367.076773867763, 6266.874662506724, 6335.176427064452, 6337.42963133311, 6348.206474190726, 6361.713722882481, 4989.750512474435, 5098.107831129611, 5112.718800465936, 5113.923291150636, 5125.282460455539, 4517.75152366623, 4534.501204867462, 4537.0, 4553.1121431321235, 4577.084583083397, 5762.4525670061275, 5771.913421298684, 5775.133729940542, 5780.132980052942, 5780.306363236355, 6336.52476064297, 6342.302346741854, 6352.936470635234, 6353.96823015882, 6363.077353783676, 4828.155072862235, 5710.885782284331, 5738.655680659173, 5779.711014449261, 5783.248177736951, 5483.75323110461, 5484.012877681976, 5508.91736623951, 5512.724363781795, 5520.171974203901, 6295.087212354275, 6296.779612713533, 6309.589876658002, 6314.778982735582, 6323.5573509854785, 6284.717187726655, 6318.936810632019, 6339.841503962253, 6350.841228969312, 6351.587146835441, 6401.167848179707, 6401.455876250385, 6405.423511883952, 6416.647084410402, 6432.2281326241155, 6060.369019565712, 6123.160610921377, 6282.8429289266305, 6283.308836027942, 6344.175257216532, 6314.242290925118, 6322.241331040304, 6330.430261276507, 6352.936470635234, 6356.110144579855, 5227.2943152675425, 6141.477974372228, 6184.721687523982, 6239.188905442264, 6293.968530157503, 6290.685465726604, 6296.6851657417865, 6302.968485157545, 6310.873782524232, 6315.810525684236, 6160.291566469913, 6160.969195153995, 6163.19878415803, 6165.568410211242, 6183.474404675473, 4730.526947305242, 6060.272767267956, 6061.939380606137, 6154.876902461836, 6279.905801412891, 5993.9700301498215, 5995.550333725076, 6006.549508786946, 6014.669193194241, 6028.819135425944], "value": 5783.60183762714, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [762.6606160258685, 779.2830595851816, 831.5925196653642, 843.586642545153, 850.4599579267164, 27040.72959270407, 28161.43677126456, 28194.718052819466, 28200.153995380148, 38673.0, 32240.67759322406, 38678.61321386785, 39282.41076383857, 39296.41055384171, 39305.01737456565, 9088.454692718442, 9204.355695101312, 9215.493147876865, 9233.6306547738, 9260.814783704322, 7200.963995180043, 7336.266373362674, 9019.323550733689, 9139.68011119611, 9141.588628511732, 7353.742619008336, 7379.151397589266, 10402.167826573856, 11128.0541154002, 11195.104391648649, 11027.889721102807, 11094.944525277322, 11111.222214444992, 11123.944380278128, 11124.165687573424, 10769.461526923622, 10840.945795271053, 10841.78316433667, 10841.891581084166, 10845.457727113691, 26709.73290267092, 27095.729042709518, 27841.86079069612, 27845.58231626527, 37655.870323890056, 3208.2781374190854, 3304.9173770655684, 3805.315043292206, 3982.4623675803687, 3988.805449873523, 27482.587761183597, 27685.0, 27819.0, 28027.0, 28188.577171342447, 2789.205076553193, 3073.523603841386, 3149.434843715988, 3184.331290429013, 3265.4938484534937, 322756.0, 324198.0, 324236.0, 324409.37795310875, 325311.373443136, 49562.0087598246, 49594.752026240356, 49629.0, 49634.75182624064, 49828.75085624549, 34515.13712157216, 42807.14385712268, 44512.887177820165, 45400.54599453963, 45515.54484455113, 12698.42857071434, 12784.424700888483, 12789.296588687712, 14143.717125657635, 14376.921730870226, 11849.703757405961, 11865.406729663482, 11895.286282823059, 11908.92819646236, 11926.642200733992, 12189.390530473442, 12235.082368822374, 12243.32661703615, 12254.0, 12267.57063502773, 4680.378887814756, 5299.973500132474, 5310.468953104659, 5317.8936421271355, 5322.201669749491, 1097.5061222449929, 1112.9760620229408, 1125.2404626876826, 1139.4986206069302, 1153.4643637085633, 25291.49417011686, 25656.358591035372, 25709.228723138334, 25854.0, 25861.35346616312, 1095.9259925273277, 1131.4286285425808, 1132.671525257666, 1134.4157758754247, 1191.891540867002, 12129.939350303368, 12295.32375719326, 13365.33173341329, 13451.932740336235, 13471.663208419868, 409010.0, 442494.0, 505113.0, 515098.0, 517983.0, 56696.0, 57373.0, 57438.42561574414, 60281.69859150676, 60405.39594604086, 1435.5047508609514, 1470.7793830925448, 1471.2423102102425, 1483.792269082351, 1485.970280594382, 28941.0, 29018.56472152877, 29049.564256536592, 29890.0, 29905.70094299029, 39665.80167099146, 46204.0, 46297.76851115723, 46357.30464042975, 46368.536314636425, 460559.0, 461469.0, 464453.0, 466044.0, 466886.0, 34334.65665343314, 34704.479432809036, 35030.64969350274, 35112.47331290084, 35157.648423515435, 34185.145371365914, 34944.951651450494, 36651.633483664824, 43464.0, 43910.34134487921, 25733.618587989153, 31830.885918992724, 35215.47176792401, 36562.45156322604, 37121.628783711814, 35063.47404788879, 35267.11832204215, 35320.29359412746, 36565.08587285339, 36675.816620916725, 35987.0, 36006.8199659, 36278.27443451063, 37091.25817483689, 38464.03839904025, 25962.87018564895, 29913.102606921828, 32220.0, 32284.677153228167, 32610.021699349058, 23865.880670596536, 23996.760032399452, 24166.637500437155, 24379.26862194137, 24430.511389772462], "value": 18226.690419836483, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.1519369403077, 393.2567447524178, 411.22689344033205, 419.3248869320395, 443.14030780286265, 12583.748325033504, 21260.0, 21775.673364899518, 22687.0, 22806.65790013151, 20907.37277881662, 21495.892520537374, 21695.891520542416, 21737.782622173774, 22274.554508909852, 6474.611523308617, 6520.67396630169, 6640.800775976729, 6713.194416670007, 6724.327567243286, 4122.0, 6507.6420796856155, 6623.370779775913, 6683.665816709169, 6684.431823295025, 4284.443022407083, 4324.675649326313, 4371.956280437187, 4439.4672639283335, 7629.122650895135, 7071.1868135164605, 7661.042369703787, 7715.382769378492, 7715.652795624211, 7733.767986960372, 7407.444441666843, 7489.700411983514, 7491.363234125106, 7502.774916752506, 7508.061492313461, 19105.14026868794, 21608.35174944754, 25477.872610637012, 26357.077502287328, 26586.734132658617, 2928.297208669925, 2964.659064207622, 2982.7762917781038, 3005.173577266269, 3021.743151832097, 14514.709705805824, 15329.693406131815, 15378.384864605403, 15673.529794106194, 16419.83580164195, 1909.3699079303935, 1948.7466629338237, 1962.6369121712387, 1965.4693232827199, 1979.1291831594197, 137808.0, 149566.79115484012, 151331.0, 159858.4014159855, 163941.54087688815, 14480.637984050483, 20698.0, 20895.37313880586, 21125.68311475329, 21479.0, 29443.411131777244, 29480.852595736884, 31921.042368728977, 33451.66548334534, 34707.78522751691, 9919.305648604528, 10485.37087774736, 10503.159747220205, 10521.26351155427, 10679.359238445719, 7006.579605223703, 8449.0, 8453.196946290092, 8657.264132548804, 8676.1323867614, 8691.826163476822, 9941.558474021227, 10102.949485252673, 10150.4623844039, 10318.48407579633, 3566.28674265148, 4118.062392473951, 4148.315527937917, 4154.833806647761, 4180.393842892824, 859.3125499600295, 872.8167084912112, 886.6409104312763, 890.9153630405101, 905.7690288976269, 19509.60980780405, 20880.79119208819, 21222.045007974677, 21739.565208695738, 22090.44773880634, 878.8882064188806, 902.5306840442933, 921.3642586615214, 928.6239073175375, 943.193569498083, 10331.741706457398, 10906.236563440483, 11392.165834443944, 11553.075753939833, 11556.94221528887, 611323.0, 704432.0, 716475.0, 716735.0, 719188.0, 108753.0, 143259.28370358082, 143977.28011359877, 146945.0, 147601.26199368935, 1018.9082982531608, 1231.2304809494067, 1274.7641686288066, 1276.6999755057554, 1280.155097635556, 20258.290959816335, 20713.585728285652, 20860.061297241966, 20889.0, 20916.895415522824, 55576.16635750548, 62715.6864215676, 65093.537840080484, 65240.0, 66259.01222963318, 90433.0, 91356.0, 91511.62732558884, 91705.0, 92410.0, 11159.832602511131, 11770.76458470843, 11958.64124076279, 12112.333821639895, 12122.333271670142, 11634.360110193682, 12011.339376334385, 12135.211211271238, 13470.865291346961, 13875.306234688427, 7474.738384156529, 11425.0, 11582.203757117706, 11740.41297935117, 11831.46758395857, 11511.136664750346, 11609.593664221711, 11658.0, 11876.871697188753, 11898.167128300936, 11507.021903138328, 11884.909923420146, 11964.863337982877, 12042.578509752117, 12075.456604452997, 10603.727552693417, 11540.24988375753, 11712.824307635563, 11945.566532015866, 12087.758244834878, 11273.492692828679, 11616.651500455, 11837.940810295893, 11859.16985810985, 12006.879931200576], "value": 11414.42777252439, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1544.3282172255076, 1557.4471062772716, 1588.2138341520947, 1589.6105454163724, 1596.7684685720567, 10484.580616775329, 11100.167487438433, 11104.44477776111, 11115.11079113672, 11134.33194008358, 9758.560864761084, 10640.78718425631, 10812.72968175796, 10813.18901082418, 10813.296675831043, 2302.20573902004, 2337.812974961999, 2343.9179628713, 2344.531093781242, 2348.3542025942916, 2276.84062115652, 2314.259436980167, 2317.142657216832, 2318.9652155217686, 2320.8027317678016, 2271.7273927128767, 2291.0263138166297, 2295.414669259345, 2309.734380546242, 2311.9884400577976, 1946.4160751774482, 2242.551489702066, 2267.7051983242072, 2269.761675024115, 2271.5116250006245, 2224.4883676754275, 2279.9658005129936, 2283.0525331987205, 2284.326123793485, 2286.439822243561, 10672.359658420442, 10777.191710621735, 10784.73038174044, 10792.136629069655, 10792.352458852494, 5570.387257401682, 5729.398413166599, 5744.798932037401, 5751.798687045934, 5763.596548241625, 3272.934541309184, 3368.5789276340456, 3582.9967609069504, 3585.4621806728937, 3588.0671025533547, 1044.639599338227, 1184.7430644621923, 1196.2882085159317, 1200.9699757506046, 1213.5691829400612, 13180.86819131806, 13598.660033499242, 13913.791293130713, 14680.55958321252, 14691.55925322242, 4417.160739459557, 4583.656225783079, 4597.126545956257, 4607.838725644587, 4620.353150558924, 11143.72140696489, 11160.386178760245, 11170.329780213213, 11183.552657893755, 11202.495887685074, 4775.6418268629295, 4935.3090567320605, 5542.86142846424, 5545.334559852843, 5548.917960997647, 4900.681455705368, 5090.821821236239, 5153.304303918998, 5157.896842063138, 5159.380874295109, 3558.466230065459, 3721.832517536717, 3757.6242375762204, 3794.2411517696573, 3810.9809450952566, 1009.9697009089739, 1016.2378216337746, 1023.2070145637042, 1031.3138019338435, 1033.9327943683636, 882.2148288023664, 909.1499448016126, 913.7441516375426, 940.4404280145927, 943.2642538819595, 6329.019002054597, 6408.775692850728, 6563.442107420828, 6620.337966203341, 6729.966350168218, 941.3457646935315, 977.7702239973601, 994.1003391930315, 1012.7215015870547, 1019.6584144311738, 3984.9003774905277, 4081.2449696806184, 4203.684723645739, 4209.431726716915, 4238.17355615652, 12702.936485317514, 13121.737565248832, 13123.278219698008, 13141.080124391392, 13158.14472059313, 12769.425375858109, 12811.679708007374, 13056.34718264083, 13123.60629181126, 13124.934375328063, 9777.853332200022, 9783.315167938175, 9838.458884761263, 9940.0, 9984.850227246598, 6109.175261339662, 6153.230846144232, 6261.154744109487, 6296.087067375113, 6335.936640633535, 11670.88329116732, 12070.879291206975, 12072.75854482888, 12076.396180191132, 12081.093917956012, 9709.70870873875, 11326.716832078935, 11654.592089276835, 12057.638270851889, 12144.696382590506, 7457.664405101675, 8266.83466330658, 8324.667013319642, 8345.290650294794, 8433.283170930294, 9972.950135249277, 9993.10062094415, 10118.241131914989, 10129.442880641636, 10164.440955747505, 8328.167183281623, 8946.329025322997, 8994.865077023718, 9041.728748137566, 9146.359754817098, 7954.522728636301, 8603.698870539502, 8639.524826134622, 8715.956420217859, 8893.822123557622, 6714.3957043866285, 7230.819229519304, 7790.961045194737, 7795.259450352208, 7820.530768153929, 5582.33012038558, 5616.558254261829, 5782.392848750821, 5808.82573522795, 5856.736446859987, 5656.321241451053, 5686.346070201815, 5931.377205393372, 5941.702914854326, 6078.513718902565], "value": 4965.914127467318, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [359.7176216669913, 370.6701036077891, 376.9849206031759, 380.93904975203975, 385.2910644414278, 4274.743515389075, 4698.2482802751565, 5020.920502092054, 5071.2139618359215, 5168.36413429152, 4095.3037983542795, 4201.600847919451, 4925.310456536079, 4944.2089265717495, 5017.494751574532, 3647.74465787395, 3904.785236811981, 4135.400366946791, 4180.979095104521, 4204.9487628092975, 3863.748856324344, 4017.067540695294, 4199.543267188683, 4215.725977811448, 4229.34445160999, 3840.347140986025, 4116.711830171874, 4149.585041495841, 4176.248275310443, 4196.853110141131, 3475.4786781982652, 3727.6645101940685, 4000.659943904772, 4126.823855201284, 4136.131412403399, 3449.965010496841, 3661.9633803662155, 3765.9058523536855, 3786.2616789726017, 3801.733878628497, 4587.977060114711, 4853.538913803183, 4876.7076724667995, 4896.216605343164, 4913.985266040906, 4235.25882970479, 4447.911041779146, 4524.846164228101, 4753.572178503917, 4811.8075276988875, 4483.663725220622, 5009.196689191888, 5253.817890974538, 5359.356877174725, 5447.350275315548, 3814.550470821098, 4006.358982562776, 4225.352112676066, 4276.379924910871, 4282.571742825724, 4100.364443511231, 5051.823186188466, 5070.188769796851, 5403.621746477748, 5489.890202196014, 3704.24063067076, 3799.4680744695765, 3839.6544311012144, 4261.531231564525, 4278.315469524861, 3803.5055442792814, 4058.898527536835, 4059.5331536873045, 4286.335617979156, 4481.619062379734, 4243.469566304212, 4399.406080179199, 4440.290488162081, 4533.206688829442, 4805.807767689324, 4518.774061296922, 5193.766280517386, 5229.163333866563, 5230.398504172069, 5445.646033007842, 1437.1879887863324, 1498.4081287891222, 1506.8342482326934, 1511.304799792108, 1527.3962339543657, 1029.629333439961, 1124.3310230413056, 1126.3354620773782, 1140.9674244808461, 1156.6183159557495, 4267.551907049778, 4601.0, 4740.506740376771, 4939.0, 4942.604591632661, 4582.931256031162, 5023.673461225008, 5049.343585333883, 5093.439721630618, 5417.783288668488, 4506.481754598198, 4603.447586289667, 4867.805287788448, 4894.161386395882, 4936.914428482199, 2468.5926822074516, 2478.958837288343, 2548.821582489208, 2796.832190068562, 2866.756325712296, 4629.768511574408, 5227.0, 5266.947330526646, 5750.798722044792, 5786.74317016364, 4600.930986035212, 5109.540141387293, 5193.584513238932, 5390.568754499709, 5686.744096515667, 5238.764255608507, 5523.210778556803, 5591.133374326986, 5599.100786811458, 5610.4670056344585, 4943.011397720398, 5055.368078990126, 5226.817061402832, 5229.764660590206, 5536.861578460571, 4388.517263100993, 5013.674111182761, 5157.535821776059, 5408.864778380572, 5468.2344471773185, 5298.602604804578, 5669.513249351537, 5758.827235182951, 5780.913286300624, 5796.59423840344, 3970.9172259507877, 4293.046663767916, 4348.695591308705, 4394.494633117232, 4423.823047078081, 4812.951870481251, 4951.405831300123, 5194.454582268807, 5479.863003424946, 5502.2296878436255, 4512.894340886503, 5286.656367336264, 5290.761915713879, 5293.497117773959, 5372.865678358073, 4981.203007518924, 5103.877147027648, 5330.920036199383, 5356.732163391737, 5364.8122315718765, 4335.371371151228, 4481.686281960231, 4802.663813533159, 5171.793128274827, 5277.472252774692, 4596.862094137181, 5229.992754166446, 5352.143657014859, 5376.0591896418755, 5380.300560927054, 4446.998850517345, 4690.859274221779, 4970.950290497049, 5236.293100431393, 5248.553872920845], "value": 4026.5727834050035, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [639.2361128451499, 726.8400951790604, 728.8702511107784, 754.698318496538, 759.1876691939624, 14664.706705865876, 15534.0, 15546.378144874205, 15553.377864885419, 15568.688626227482, 16195.433159839407, 17067.658646827054, 17102.828971710278, 17186.05476698781, 17662.38181663642, 941.3222479814523, 955.8948515663271, 961.7066794627635, 963.2197919685043, 967.2890425537224, 965.9082387173207, 965.9420434773901, 966.0773960867355, 966.6809952715587, 970.3110791338158, 962.7785609309863, 1005.5726316315573, 1006.7583779892809, 1008.0222184481041, 1011.3375738891039, 984.2126298960874, 985.4776968206862, 986.6891929042329, 987.7185002274317, 988.4168340678998, 741.0921621014269, 742.0464702856857, 742.9331360177556, 743.2753065760894, 745.9403247740167, 14984.325705343286, 15090.17004064776, 15116.924415377853, 15260.084394936228, 16046.759298610414, 14519.20144392058, 14781.630459238497, 14791.852081479155, 14799.40802367904, 14837.777433338508, 11689.76620467586, 11748.823767643493, 12071.758564828655, 12089.576864809778, 12295.877041229563, 3600.1899572596217, 3706.129059670975, 3741.7754934704003, 3747.6439738224826, 3871.361225397806, 111680.4415977923, 114731.0, 115041.0, 116025.83974160235, 117415.65168696664, 11150.832737508943, 11462.083033357312, 11550.306981581132, 11634.185607007428, 11785.88214117848, 24506.877465612557, 24737.752622473905, 24773.752262477145, 24862.005519779366, 25160.245192643884, 7833.92166078332, 7917.406194535433, 7923.418545270217, 7985.401094917905, 8122.431429799975, 4238.660907127422, 4272.658187345067, 4352.347147927836, 4406.294992801137, 4411.536788637147, 3455.0, 3529.1882866940746, 3531.1878267998504, 3532.593751718534, 3536.8231588420476, 624.2508989212963, 631.6494345638215, 648.3872740260408, 657.0669649098196, 657.989985372451, 596.3529570416147, 628.4972022382167, 638.2883085359883, 688.7727050073464, 710.992890071103, 9438.38650487716, 9715.854262186072, 9734.0, 10268.845967310497, 10393.9480302598, 617.4473845907887, 653.8888388973886, 676.5399528320789, 684.6918886501095, 691.1395312835552, 4865.927011094836, 4879.878003049881, 4880.8364308573355, 4907.975460122677, 4998.675086119463, 65488.0, 103248.96751032394, 104102.47948760208, 106427.40358894622, 106877.0, 74360.25639743642, 88644.11355886358, 89863.20273594491, 91667.0, 92923.53538232266, 79911.0, 80254.59872700598, 81734.59132704299, 81951.5902420496, 81961.0, 9447.622095116394, 9448.244140468609, 9449.574769135268, 9454.385464944757, 9488.667896623585, 45887.80514630616, 50653.49346506635, 52363.21455178099, 52783.94432111413, 52855.471445286596, 63948.0, 65666.0, 67206.66396667986, 67694.0, 68293.65853170703, 11528.250663706833, 11579.0, 11646.88353116458, 11788.29229950299, 12271.58573615151, 12106.213096148722, 12480.937595311965, 12508.56220032331, 12575.308358040029, 12631.684207894876, 11425.107209763233, 11817.99669211325, 11844.466998984894, 12237.755244894874, 12441.066919980856, 11537.538498459968, 11829.704257393634, 12224.0, 12237.877621223673, 12389.75220495567, 11741.47163377633, 11834.763304733684, 11977.401129943642, 12131.150819442555, 12179.0, 9727.221822254343, 9909.355891867006, 10009.178636104347, 10189.949050254701, 10725.624603138853, 8879.467231966102, 9875.160611348116, 9886.604535818487, 9897.0, 9901.405915645084], "value": 7541.231272140926, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1446.4, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 117.0, 114.0, 116.0, 115.0, 117.0, 115.0, 115.0, 113.0, 118.0], "value": 115.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [144.0, 111.0, 110.0, 146.0, 113.0, 109.0, 107.0, 129.0, 128.0, 109.0], "value": 120.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 183.0, 181.0, 185.0, 184.0, 182.0, 183.0, 180.0, 182.0, 182.0], "value": 182.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 59.0, 66.0, 103.0, 87.0, 81.0, 61.0, 59.0, 77.0, 60.0], "value": 73.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 71.0, 90.0, 71.0, 70.0, 69.0, 84.0, 70.0, 69.0, 84.0], "value": 76.6, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 85.0, 86.0, 93.0, 86.0, 86.0, 86.0, 85.0, 86.0, 85.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 93.0, 93.0, 101.0, 145.0, 94.0, 94.0, 93.0], "value": 99.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 84.0, 85.0, 83.0, 86.0, 82.0, 84.0, 86.0, 86.0, 85.0], "value": 84.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [62.0, 61.0, 60.0, 60.0, 63.0, 64.0, 63.0, 60.0, 64.0, 62.0], "value": 61.9, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [61.0, 53.0, 61.0, 66.0, 62.0, 58.0, 59.0, 60.0, 60.0, 59.0], "value": 59.9, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 85.0, 87.0, 87.0, 87.0, 86.0, 85.0, 86.0, 88.0], "value": 86.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [163.0, 141.0, 143.0, 138.0, 138.0, 142.0, 138.0, 141.0, 173.0, 157.0], "value": 147.4, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 171.0, 183.0, 225.0, 196.0, 172.0, 173.0, 170.0, 173.0, 180.0], "value": 181.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 67.0, 66.0, 66.0, 67.0, 66.0, 74.0, 82.0, 82.0], "value": 70.4, "unit": "score"}]}]} 04:19:00 INFO - Return code: 0 04:19:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:19:00 ERROR - # TBPL SUCCESS # 04:19:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:19:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:19:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:19:00 INFO - 2017-03-10 04:19:00.924 screenresolution[1654:10071] starting screenresolution argv=screenresolution get 04:19:00 INFO - 2017-03-10 04:19:00.927 screenresolution[1654:10071] Display 0: 1600x1200x32@60 04:19:00 INFO - 2017-03-10 04:19:00.933 screenresolution[1655:10074] starting screenresolution argv=screenresolution list 04:19:00 INFO - Available Modes on Display 0 04:19:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:19:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:19:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:19:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:19:01 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:19:01 INFO - Intel Iris: 04:19:01 INFO - Chipset Model: Intel Iris 04:19:01 INFO - Type: GPU 04:19:01 INFO - Bus: Built-In 04:19:01 INFO - VRAM (Dynamic, Max): 1536 MB 04:19:01 INFO - Vendor: Intel (0x8086) 04:19:01 INFO - Device ID: 0x0a2e 04:19:01 INFO - Revision ID: 0x0009 04:19:01 INFO - Displays: 04:19:01 INFO - Display: 04:19:01 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:19:01 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:19:01 INFO - Display Serial Number: 1600x1200 60 04:19:01 INFO - Main Display: Yes 04:19:01 INFO - Mirror: Off 04:19:01 INFO - Online: Yes 04:19:01 INFO - Rotation: Supported 04:19:01 INFO - Return code: 0 04:19:01 INFO - Running post-action listener: _resource_record_post_action 04:19:01 INFO - [mozharness: 2017-03-10 12:19:01.176768Z] Finished run-tests step (success) 04:19:01 INFO - Running post-run listener: _resource_record_post_run 04:19:01 INFO - Total resource usage - Wall time: 1203s; CPU: 54.0%; Read bytes: 37901312; Write bytes: 512140288; Read time: 240; Write time: 1600 04:19:01 INFO - TinderboxPrint: CPU usage
54.1% 04:19:01 INFO - TinderboxPrint: I/O read bytes / time
37,901,312 / 240 04:19:01 INFO - TinderboxPrint: I/O write bytes / time
512,140,288 / 1,600 04:19:01 INFO - TinderboxPrint: CPU idle
2,211.3 (45.9%) 04:19:01 INFO - TinderboxPrint: CPU system
957.8 (19.9%) 04:19:01 INFO - TinderboxPrint: CPU user
1,644.6 (34.2%) 04:19:01 INFO - TinderboxPrint: Swap in / out
247,402,496 / 0 04:19:01 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205507072; Write bytes: 202479616; Read time: 15489; Write time: 427 04:19:01 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 35836928; Write bytes: 298802176; Read time: 221; Write time: 1134 04:19:01 INFO - Running post-run listener: _upload_blobber_files 04:19:01 INFO - Blob upload gear active. 04:19:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:19:01 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:19:01 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:19:01 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:19:02 INFO - (blobuploader) - INFO - Open directory for files ... 04:19:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:19:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:04 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:19:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:04 INFO - (blobuploader) - INFO - Done attempting. 04:19:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:19:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:05 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:19:05 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:05 INFO - (blobuploader) - INFO - Done attempting. 04:19:05 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:19:05 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:05 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:07 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:19:07 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:07 INFO - (blobuploader) - INFO - Done attempting. 04:19:07 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:19:07 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:19:07 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:19:10 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:19:10 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:19:10 INFO - (blobuploader) - INFO - Done attempting. 04:19:10 INFO - (blobuploader) - INFO - Iteration through files over. 04:19:10 INFO - Return code: 0 04:19:10 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:19:10 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:19:10 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e0c50c34f67f1593af07ef6d3170cafb62b78b91aede893269c2ec6d21fd972a9c9b9edf07e225d72b9521856c421ca08c90707b752292557285dbd7b17b03c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deac4b0a9494c8d4398816dd1d0ac7dd1345e6493d410c0c307319f51d35db07df9925d38042721de6e6e6031d569f09ab2b8a6073fca0f23687b5347187a649", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/397931f731c3d817cb0a4181c169ed60e78481418dc0711d5de2248ba543355a343229c2369f37f9e350ab0f2b3e110e02304a79da3802a6659f9c5f97a4fb65", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3bd603570f1db071093f4ae538111c4f9f334718f9f6fed0903228911f966b0d775220c0db70c0399aea74529904475835eb26c2bc3748cd21294bab66672ca"} 04:19:10 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:19:10 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:19:10 INFO - Contents: 04:19:10 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e0c50c34f67f1593af07ef6d3170cafb62b78b91aede893269c2ec6d21fd972a9c9b9edf07e225d72b9521856c421ca08c90707b752292557285dbd7b17b03c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deac4b0a9494c8d4398816dd1d0ac7dd1345e6493d410c0c307319f51d35db07df9925d38042721de6e6e6031d569f09ab2b8a6073fca0f23687b5347187a649", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/397931f731c3d817cb0a4181c169ed60e78481418dc0711d5de2248ba543355a343229c2369f37f9e350ab0f2b3e110e02304a79da3802a6659f9c5f97a4fb65", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3bd603570f1db071093f4ae538111c4f9f334718f9f6fed0903228911f966b0d775220c0db70c0399aea74529904475835eb26c2bc3748cd21294bab66672ca"} 04:19:10 INFO - Running post-run listener: copy_logs_to_upload_dir 04:19:10 INFO - Copying logs to upload dir... 04:19:10 INFO - mkdir: /builds/slave/test/build/upload/logs 04:19:10 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1291.644103 ========= master_lag: 0.12 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 31 secs) (at 2017-03-10 04:19:10.800538) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 04:19:10.804102) ========= 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.4w2b9tEXuQ/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.tGLSUVM05U/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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/6e0c50c34f67f1593af07ef6d3170cafb62b78b91aede893269c2ec6d21fd972a9c9b9edf07e225d72b9521856c421ca08c90707b752292557285dbd7b17b03c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deac4b0a9494c8d4398816dd1d0ac7dd1345e6493d410c0c307319f51d35db07df9925d38042721de6e6e6031d569f09ab2b8a6073fca0f23687b5347187a649", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/397931f731c3d817cb0a4181c169ed60e78481418dc0711d5de2248ba543355a343229c2369f37f9e350ab0f2b3e110e02304a79da3802a6659f9c5f97a4fb65", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3bd603570f1db071093f4ae538111c4f9f334718f9f6fed0903228911f966b0d775220c0db70c0399aea74529904475835eb26c2bc3748cd21294bab66672ca"} build_url:https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011501 build_url: 'https://queue.taskcluster.net/v1/task/QcwEipUvQRWJQee11GNyYw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6e0c50c34f67f1593af07ef6d3170cafb62b78b91aede893269c2ec6d21fd972a9c9b9edf07e225d72b9521856c421ca08c90707b752292557285dbd7b17b03c", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/deac4b0a9494c8d4398816dd1d0ac7dd1345e6493d410c0c307319f51d35db07df9925d38042721de6e6e6031d569f09ab2b8a6073fca0f23687b5347187a649", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/397931f731c3d817cb0a4181c169ed60e78481418dc0711d5de2248ba543355a343229c2369f37f9e350ab0f2b3e110e02304a79da3802a6659f9c5f97a4fb65", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/b3bd603570f1db071093f4ae538111c4f9f334718f9f6fed0903228911f966b0d775220c0db70c0399aea74529904475835eb26c2bc3748cd21294bab66672ca"}' ========= master_lag: 0.09 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 04:19:10.906560) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 04:19:10.906898) ========= 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.4w2b9tEXuQ/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.tGLSUVM05U/Listeners TMPDIR=/var/folders/9g/44pf50cs62vfzf8l355hkc3800000w/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.005124 ========= master_lag: 0.16 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 04:19:11.076148) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 04:19:11.076459) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 04:19:11.076850) ========= ========= Total master_lag: 0.46 =========