builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0152 starttime: 1489149122.15 results: success (0) buildid: 20170310030521 builduid: a2c1015698bd457898f68844dfa1d8a7 revision: 92c5b7bcd598c55f88979c014acfb79fd1ad7e45 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 04:32:02.147559) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-10 04:32:02.148009) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 04:32:02.148285) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-10 04:32:02.175186) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 04:32:02.175535) ========= 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.YcbZMisP8l/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.9jhi2ST41v/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 04:32:02-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 164M=0s 2017-03-10 04:32:02 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.159267 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 04:32:02.359265) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 04:32:02.359624) ========= 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.YcbZMisP8l/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.9jhi2ST41v/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.026957 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 04:32:02.409695) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 04:32:02.410044) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 92c5b7bcd598c55f88979c014acfb79fd1ad7e45 --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 92c5b7bcd598c55f88979c014acfb79fd1ad7e45 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.YcbZMisP8l/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.9jhi2ST41v/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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 04:32:02,512 truncating revision to first 12 chars 2017-03-10 04:32:02,512 Setting DEBUG logging. 2017-03-10 04:32:02,512 attempt 1/10 2017-03-10 04:32:02,512 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/92c5b7bcd598?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-10 04:32:03,932 unpacking tar archive at: mozilla-central-92c5b7bcd598/testing/mozharness/ program finished with exit code 0 elapsedTime=1.700265 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-10 04:32:04.133653) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 04:32:04.133982) ========= script_repo_revision: 92c5b7bcd598c55f88979c014acfb79fd1ad7e45 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-10 04:32:04.134363) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 04:32:04.134634) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-10 04:32:04.154731) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-10 04:32:04.155076) ========= /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.YcbZMisP8l/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.9jhi2ST41v/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:32:04 INFO - MultiFileLogger online at 20170310 04:32:04 in /builds/slave/test 04:32:04 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:32:04 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:32:04 INFO - {'append_to_log': False, 04:32:04 INFO - 'base_work_dir': '/builds/slave/test', 04:32:04 INFO - 'blob_upload_branch': 'Firefox', 04:32:04 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:32:04 INFO - 'branch': 'Firefox', 04:32:04 INFO - 'buildbot_json_path': 'buildprops.json', 04:32:04 INFO - 'config_files': ('talos/mac_config.py',), 04:32:04 INFO - 'default_actions': ('clobber', 04:32:04 INFO - 'read-buildbot-config', 04:32:04 INFO - 'download-and-extract', 04:32:04 INFO - 'populate-webroot', 04:32:04 INFO - 'create-virtualenv', 04:32:04 INFO - 'install', 04:32:04 INFO - 'run-tests'), 04:32:04 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:32:04 INFO - 'download_minidump_stackwalk': True, 04:32:04 INFO - 'download_symbols': 'ondemand', 04:32:04 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:32:04 INFO - 'tooltool.py': '/tools/tooltool.py', 04:32:04 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:32:04 INFO - '/tools/misc-python/virtualenv.py')}, 04:32:04 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:32:04 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:32:04 INFO - 'gecko_profile': False, 04:32:04 INFO - 'gecko_profile_interval': 0, 04:32:04 INFO - 'installer_path': 'installer.exe', 04:32:04 INFO - 'log_level': 'info', 04:32:04 INFO - 'log_name': 'talos', 04:32:04 INFO - 'log_to_console': True, 04:32:04 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:32:04 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:32:04 INFO - 'opt_config_files': (), 04:32:04 INFO - 'pip_index': False, 04:32:04 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:32:04 INFO - 'cmd': ('bash', 04:32:04 INFO - '-c', 04:32:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:32:04 INFO - 'enabled': True, 04:32:04 INFO - 'halt_on_failure': False, 04:32:04 INFO - 'name': 'check_screen_resolution'},), 04:32:04 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:32:04 INFO - 'cmd': ('bash', 04:32:04 INFO - '-c', 04:32:04 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:32:04 INFO - 'enabled': True, 04:32:04 INFO - 'halt_on_failure': False, 04:32:04 INFO - 'name': 'check_screen_resolution'},), 04:32:04 INFO - 'run_cmd_checks_enabled': True, 04:32:04 INFO - 'suite': 'dromaeojs', 04:32:04 INFO - 'system_bits': '32', 04:32:04 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:32:04 INFO - 'title': 't-yosemite-r7-0152', 04:32:04 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:32:04 INFO - 'use_talos_json': True, 04:32:04 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:32:04 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:32:04 INFO - 'work_dir': 'build'} 04:32:04 INFO - [mozharness: 2017-03-10 12:32:04.370725Z] Running clobber step. 04:32:04 INFO - Running pre-action listener: _resource_record_pre_action 04:32:04 INFO - Running main action method: clobber 04:32:04 INFO - rmtree: /builds/slave/test/build 04:32:04 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:32:06 INFO - Running post-action listener: _resource_record_post_action 04:32:06 INFO - [mozharness: 2017-03-10 12:32:06.975698Z] Finished clobber step (success) 04:32:06 INFO - [mozharness: 2017-03-10 12:32:06.975835Z] Running read-buildbot-config step. 04:32:06 INFO - Running pre-action listener: _resource_record_pre_action 04:32:06 INFO - Running main action method: read_buildbot_config 04:32:06 INFO - Using buildbot properties: 04:32:06 INFO - { 04:32:06 INFO - "project": "", 04:32:06 INFO - "product": "firefox", 04:32:06 INFO - "script_repo_revision": "production", 04:32:06 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:32:06 INFO - "repository": "", 04:32:06 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:32:06 INFO - "buildid": "20170310030521", 04:32:06 INFO - "pgo_build": "False", 04:32:06 INFO - "basedir": "/builds/slave/test", 04:32:06 INFO - "buildnumber": 9, 04:32:06 INFO - "slavename": "t-yosemite-r7-0152", 04:32:06 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:32:06 INFO - "platform": "yosemite_r7", 04:32:06 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:32:06 INFO - "branch": "mozilla-central", 04:32:06 INFO - "repo_path": "mozilla-central", 04:32:06 INFO - "revision": "92c5b7bcd598c55f88979c014acfb79fd1ad7e45", 04:32:06 INFO - "stage_platform": "macosx64", 04:32:06 INFO - "builduid": "a2c1015698bd457898f68844dfa1d8a7", 04:32:06 INFO - "slavebuilddir": "test" 04:32:06 INFO - } 04:32:06 INFO - Found installer url https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:32:06 INFO - Running post-action listener: _resource_record_post_action 04:32:06 INFO - [mozharness: 2017-03-10 12:32:06.981006Z] Finished read-buildbot-config step (success) 04:32:06 INFO - [mozharness: 2017-03-10 12:32:06.981138Z] Running download-and-extract step. 04:32:06 INFO - Running pre-action listener: _resource_record_pre_action 04:32:06 INFO - Running main action method: download_and_extract 04:32:06 INFO - mkdir: /builds/slave/test/build/tests 04:32:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:06 INFO - trying https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:32:06 INFO - Downloading https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/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 04:32:06 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/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 04:32:08 INFO - Downloaded 1199 bytes. 04:32:08 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:32:08 INFO - Using the following test package requirements: 04:32:08 INFO - {u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:32:08 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:32:08 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:32:08 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:32:08 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:32:08 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:32:08 INFO - u'jsshell-mac.zip'], 04:32:08 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:32:08 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:32:08 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:32:08 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:32:08 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:32:08 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:32:08 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:32:08 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:32:08 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:32:08 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:32:08 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:32:08 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:32:08 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:32:08 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:32:08 INFO - Fetch https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:32:09 INFO - Expected file size: 51786147 04:32:09 INFO - Obtained file size: 51786147 04:32:25 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 04:32:25 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:32:25 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:32:25 INFO - Fetch https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:32:27 INFO - Expected file size: 51786147 04:32:27 INFO - Obtained file size: 51786147 04:32:42 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:32:42 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:32:42 INFO - Fetch https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:32:44 INFO - Expected file size: 14404424 04:32:44 INFO - Obtained file size: 14404424 04:32:44 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:44 INFO - trying https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:32:44 INFO - Downloading https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:32:44 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/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 04:32:46 INFO - Downloaded 74926985 bytes. 04:32:46 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:32:46 INFO - mkdir: /builds/slave/test/properties 04:32:46 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:32:46 INFO - Writing to file /builds/slave/test/properties/build_url 04:32:46 INFO - Contents: 04:32:46 INFO - build_url:https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:32:47 INFO - Running post-action listener: _resource_record_post_action 04:32:47 INFO - Running post-action listener: set_extra_try_arguments 04:32:47 INFO - [mozharness: 2017-03-10 12:32:47.305094Z] Finished download-and-extract step (success) 04:32:47 INFO - [mozharness: 2017-03-10 12:32:47.305229Z] Running populate-webroot step. 04:32:47 INFO - Running pre-action listener: _resource_record_pre_action 04:32:47 INFO - Running main action method: populate_webroot 04:32:47 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:32:47 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:32:47 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:32:47 INFO - '--tppagecycles', 04:32:47 INFO - '7'], 04:32:47 INFO - 'tests': ['tsvgm']}}, 04:32:47 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:32:47 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:32:47 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:32:47 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:32:47 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:32:47 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:32:47 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:32:47 INFO - 'talos_options': ['--disable-e10s'], 04:32:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:47 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:32:47 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:32:47 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:32:47 INFO - 'talos_options': ['--disable-e10s'], 04:32:47 INFO - 'tests': ['damp', 'tps']}, 04:32:47 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:32:47 INFO - 'tests': ['damp', 'tps']}, 04:32:47 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:32:47 INFO - 'tests': ['dromaeo_dom']}, 04:32:47 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:32:47 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:32:47 INFO - 'tests': ['basic_compositor_video']}, 04:32:47 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:32:47 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:32:47 INFO - 'tests': ['a11yr', 04:32:47 INFO - 'ts_paint', 04:32:47 INFO - 'tpaint', 04:32:47 INFO - 'sessionrestore', 04:32:47 INFO - 'sessionrestore_no_auto_restore', 04:32:47 INFO - 'tabpaint']}, 04:32:47 INFO - 'other-e10s': {'tests': ['a11yr', 04:32:47 INFO - 'ts_paint', 04:32:47 INFO - 'tpaint', 04:32:47 INFO - 'sessionrestore', 04:32:47 INFO - 'sessionrestore_no_auto_restore', 04:32:47 INFO - 'tabpaint']}, 04:32:47 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:32:47 INFO - 'ts_paint', 04:32:47 INFO - 'tpaint', 04:32:47 INFO - 'sessionrestore', 04:32:47 INFO - 'sessionrestore_no_auto_restore', 04:32:47 INFO - 'tabpaint']}, 04:32:47 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:32:47 INFO - 'ts_paint', 04:32:47 INFO - 'tpaint', 04:32:47 INFO - 'sessionrestore', 04:32:47 INFO - 'sessionrestore_no_auto_restore', 04:32:47 INFO - 'tabpaint']}, 04:32:47 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:32:47 INFO - 'tests': ['a11yr', 04:32:47 INFO - 'ts_paint', 04:32:47 INFO - 'tpaint', 04:32:47 INFO - 'sessionrestore', 04:32:47 INFO - 'sessionrestore_no_auto_restore', 04:32:47 INFO - 'tabpaint']}, 04:32:47 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:32:47 INFO - 'tests': ['a11yr', 04:32:47 INFO - 'ts_paint', 04:32:47 INFO - 'tpaint', 04:32:47 INFO - 'sessionrestore', 04:32:47 INFO - 'sessionrestore_no_auto_restore', 04:32:47 INFO - 'tabpaint']}, 04:32:47 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:32:47 INFO - 'tests': ['tsvgx', 04:32:47 INFO - 'tsvgr_opacity', 04:32:47 INFO - 'tart', 04:32:47 INFO - 'tscrollx', 04:32:47 INFO - 'cart', 04:32:47 INFO - 'tsvg_static']}, 04:32:47 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:32:47 INFO - 'tsvgr_opacity', 04:32:47 INFO - 'tart', 04:32:47 INFO - 'tscrollx', 04:32:47 INFO - 'cart', 04:32:47 INFO - 'tsvg_static']}, 04:32:47 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:32:47 INFO - 'talos_options': ['--disable-e10s'], 04:32:47 INFO - 'tests': ['tp5o']}, 04:32:47 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:32:47 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:32:47 INFO - 'talos_options': ['--disable-e10s', 04:32:47 INFO - '--xperf_path', 04:32:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:47 INFO - 'tests': ['tp5n']}, 04:32:47 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:32:47 INFO - 'talos_options': ['--xperf_path', 04:32:47 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:32:47 INFO - 'tests': ['tp5n']}}, 04:32:47 INFO - 'talos.zip': {'path': '', 04:32:47 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:32:47 INFO - Running post-action listener: _resource_record_post_action 04:32:47 INFO - [mozharness: 2017-03-10 12:32:47.323610Z] Finished populate-webroot step (success) 04:32:47 INFO - [mozharness: 2017-03-10 12:32:47.323715Z] Running create-virtualenv step. 04:32:47 INFO - Running pre-action listener: _resource_record_pre_action 04:32:47 INFO - Running main action method: create_virtualenv 04:32:47 INFO - Creating virtualenv /builds/slave/test/build/venv 04:32:47 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:32:47 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:32:47 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:32:47 INFO - Using real prefix '/tools/python27' 04:32:47 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:32:48 INFO - Installing distribute.............................................................................................................................................................................................done. 04:32:51 INFO - Installing pip.................done. 04:32:51 INFO - Return code: 0 04:32:51 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:32:51 INFO - Reading from file tmpfile_stdout 04:32:51 INFO - Output received: 04:32:51 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:32:51 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:51 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 0x10895ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10895d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb23574340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108738d30>, '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 0x10865fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10872dbe8>, '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.YcbZMisP8l/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.9jhi2ST41v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:32:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcbZMisP8l/Render', 04:32:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:51 INFO - 'HOME': '/Users/cltbld', 04:32:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:51 INFO - 'LOGNAME': 'cltbld', 04:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:51 INFO - 'MOZ_NO_REMOTE': '1', 04:32:51 INFO - 'NO_EM_RESTART': '1', 04:32:51 INFO - 'PAGER': '/bin/cat', 04:32:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:51 INFO - 'PWD': '/builds/slave/test', 04:32:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:51 INFO - 'SHELL': '/bin/bash', 04:32:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9jhi2ST41v/Listeners', 04:32:51 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:32:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:51 INFO - 'USER': 'cltbld', 04:32:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:51 INFO - 'XPC_FLAGS': '0x0', 04:32:51 INFO - 'XPC_SERVICE_NAME': '0', 04:32:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:51 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:32:51 INFO - Cleaning up... 04:32:51 INFO - Return code: 0 04:32:51 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:51 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 0x10895ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10895d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb23574340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108738d30>, '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 0x10865fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10872dbe8>, '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.YcbZMisP8l/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.9jhi2ST41v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:32:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:32:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcbZMisP8l/Render', 04:32:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:51 INFO - 'HOME': '/Users/cltbld', 04:32:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:51 INFO - 'LOGNAME': 'cltbld', 04:32:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:51 INFO - 'MOZ_NO_REMOTE': '1', 04:32:51 INFO - 'NO_EM_RESTART': '1', 04:32:51 INFO - 'PAGER': '/bin/cat', 04:32:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:51 INFO - 'PWD': '/builds/slave/test', 04:32:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:51 INFO - 'SHELL': '/bin/bash', 04:32:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9jhi2ST41v/Listeners', 04:32:51 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:32:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:51 INFO - 'USER': 'cltbld', 04:32:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:51 INFO - 'XPC_FLAGS': '0x0', 04:32:51 INFO - 'XPC_SERVICE_NAME': '0', 04:32:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:51 INFO - Downloading/unpacking psutil>=3.1.1 04:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:32:55 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:55 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:55 INFO - Installing collected packages: psutil 04:32:55 INFO - Running setup.py install for psutil 04:32:55 INFO - building 'psutil._psutil_osx' extension 04:32:55 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:32:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:32:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:32:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:32:56 INFO - building 'psutil._psutil_posix' extension 04:32:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:32:56 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:32:56 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:32:56 INFO - ^ 04:32:56 INFO - 1 warning generated. 04:32:56 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:32:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:32:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:32:56 INFO - Successfully installed psutil 04:32:56 INFO - Cleaning up... 04:32:56 INFO - Return code: 0 04:32:56 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:32:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:32:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:32: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10895ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10895d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb23574340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108738d30>, '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 0x10865fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10872dbe8>, '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.YcbZMisP8l/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.9jhi2ST41v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:32: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:32: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 mozsystemmonitor==0.3 04:32:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcbZMisP8l/Render', 04:32:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:32:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:32:56 INFO - 'HOME': '/Users/cltbld', 04:32:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:32:56 INFO - 'LOGNAME': 'cltbld', 04:32:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:32:56 INFO - 'MOZ_NO_REMOTE': '1', 04:32:56 INFO - 'NO_EM_RESTART': '1', 04:32:56 INFO - 'PAGER': '/bin/cat', 04:32:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:32:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:32:56 INFO - 'PWD': '/builds/slave/test', 04:32:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:32:56 INFO - 'SHELL': '/bin/bash', 04:32:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9jhi2ST41v/Listeners', 04:32:56 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:32:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:32:56 INFO - 'USER': 'cltbld', 04:32:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:32:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:32:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:32:56 INFO - 'XPC_FLAGS': '0x0', 04:32:56 INFO - 'XPC_SERVICE_NAME': '0', 04:32:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:32:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:32:56 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:32:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:32:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:32:59 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:32:59 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:32:59 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:32:59 INFO - Installing collected packages: mozsystemmonitor 04:32:59 INFO - Running setup.py install for mozsystemmonitor 04:32:59 INFO - Successfully installed mozsystemmonitor 04:32:59 INFO - Cleaning up... 04:32:59 INFO - Return code: 0 04:32:59 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:00 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:00 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:00 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:00 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 0x10895ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10895d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb23574340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108738d30>, '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 0x10865fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10872dbe8>, '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.YcbZMisP8l/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.9jhi2ST41v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:33:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:33:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcbZMisP8l/Render', 04:33:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:00 INFO - 'HOME': '/Users/cltbld', 04:33:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:00 INFO - 'LOGNAME': 'cltbld', 04:33:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:00 INFO - 'MOZ_NO_REMOTE': '1', 04:33:00 INFO - 'NO_EM_RESTART': '1', 04:33:00 INFO - 'PAGER': '/bin/cat', 04:33:00 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:00 INFO - 'PWD': '/builds/slave/test', 04:33:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:00 INFO - 'SHELL': '/bin/bash', 04:33:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9jhi2ST41v/Listeners', 04:33:00 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:33:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:00 INFO - 'USER': 'cltbld', 04:33:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:00 INFO - 'XPC_FLAGS': '0x0', 04:33:00 INFO - 'XPC_SERVICE_NAME': '0', 04:33:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:00 INFO - Downloading/unpacking jsonschema==2.5.1 04:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:04 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:33:04 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:04 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:04 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:04 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:04 INFO - Downloading functools32-3.2.3-2.tar.gz 04:33:04 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:33:04 INFO - warning: no files found matching '*.txt' 04:33:04 INFO - no previously-included directories found matching 'build' 04:33:04 INFO - no previously-included directories found matching 'dist' 04:33:04 INFO - no previously-included directories found matching '.git*' 04:33:04 INFO - Installing collected packages: jsonschema, functools32 04:33:04 INFO - Running setup.py install for functools32 04:33:04 INFO - warning: no files found matching '*.txt' 04:33:04 INFO - no previously-included directories found matching 'build' 04:33:04 INFO - no previously-included directories found matching 'dist' 04:33:04 INFO - no previously-included directories found matching '.git*' 04:33:04 INFO - Successfully installed jsonschema functools32 04:33:04 INFO - Cleaning up... 04:33:05 INFO - Return code: 0 04:33:05 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:05 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 0x10895ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10895d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb23574340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108738d30>, '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 0x10865fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10872dbe8>, '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.YcbZMisP8l/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.9jhi2ST41v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:33:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcbZMisP8l/Render', 04:33:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:05 INFO - 'HOME': '/Users/cltbld', 04:33:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:05 INFO - 'LOGNAME': 'cltbld', 04:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:05 INFO - 'MOZ_NO_REMOTE': '1', 04:33:05 INFO - 'NO_EM_RESTART': '1', 04:33:05 INFO - 'PAGER': '/bin/cat', 04:33:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:05 INFO - 'PWD': '/builds/slave/test', 04:33:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:05 INFO - 'SHELL': '/bin/bash', 04:33:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9jhi2ST41v/Listeners', 04:33:05 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:33:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:05 INFO - 'USER': 'cltbld', 04:33:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:05 INFO - 'XPC_FLAGS': '0x0', 04:33:05 INFO - 'XPC_SERVICE_NAME': '0', 04:33:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:05 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:33:05 INFO - Cleaning up... 04:33:05 INFO - Return code: 0 04:33:05 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:05 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:05 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:05 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:05 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 0x10895ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10895d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb23574340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108738d30>, '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 0x10865fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10872dbe8>, '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.YcbZMisP8l/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.9jhi2ST41v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:05 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:33:05 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:33:05 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcbZMisP8l/Render', 04:33:05 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:05 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:05 INFO - 'HOME': '/Users/cltbld', 04:33:05 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:05 INFO - 'LOGNAME': 'cltbld', 04:33:05 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:05 INFO - 'MOZ_NO_REMOTE': '1', 04:33:05 INFO - 'NO_EM_RESTART': '1', 04:33:05 INFO - 'PAGER': '/bin/cat', 04:33:05 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:05 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:05 INFO - 'PWD': '/builds/slave/test', 04:33:05 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:05 INFO - 'SHELL': '/bin/bash', 04:33:05 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9jhi2ST41v/Listeners', 04:33:05 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:33:05 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:05 INFO - 'USER': 'cltbld', 04:33:05 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:05 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:05 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:05 INFO - 'XPC_FLAGS': '0x0', 04:33:05 INFO - 'XPC_SERVICE_NAME': '0', 04:33:05 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:05 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:05 INFO - Downloading/unpacking blobuploader==1.2.4 04:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:05 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:05 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:05 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:05 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:08 INFO - Downloading blobuploader-1.2.4.tar.gz 04:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:33:08 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:33:08 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:09 INFO - Downloading docopt-0.6.1.tar.gz 04:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:33:09 INFO - Installing collected packages: blobuploader, requests, docopt 04:33:09 INFO - Running setup.py install for blobuploader 04:33:09 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:33:09 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:33:09 INFO - Running setup.py install for requests 04:33:10 INFO - Running setup.py install for docopt 04:33:10 INFO - Successfully installed blobuploader requests docopt 04:33:10 INFO - Cleaning up... 04:33:10 INFO - Return code: 0 04:33:10 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:10 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 0x10895ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10895d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb23574340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108738d30>, '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 0x10865fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10872dbe8>, '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.YcbZMisP8l/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.9jhi2ST41v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:33:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcbZMisP8l/Render', 04:33:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:10 INFO - 'HOME': '/Users/cltbld', 04:33:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:10 INFO - 'LOGNAME': 'cltbld', 04:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:10 INFO - 'MOZ_NO_REMOTE': '1', 04:33:10 INFO - 'NO_EM_RESTART': '1', 04:33:10 INFO - 'PAGER': '/bin/cat', 04:33:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:10 INFO - 'PWD': '/builds/slave/test', 04:33:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:10 INFO - 'SHELL': '/bin/bash', 04:33:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9jhi2ST41v/Listeners', 04:33:10 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:33:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:10 INFO - 'USER': 'cltbld', 04:33:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:10 INFO - 'XPC_FLAGS': '0x0', 04:33:10 INFO - 'XPC_SERVICE_NAME': '0', 04:33:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:33:10 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-TL4t8h-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:33:10 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-glIoor-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:33:10 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:33:10 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-bWZ3xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:33:11 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-0ABNS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:33:11 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-SDYiac-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:33:11 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-H7j60G-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:33:11 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-eTIcSS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:33:11 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-3fWzRV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:33:11 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-HOM_Aj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:33:11 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-a19xmy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:33:11 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-ZOFAPB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:33:11 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-l6KPzT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:33:11 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:33:11 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-FbhJFZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:33:12 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-z0j5Y3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:12 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-psdAzO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:33:12 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-erlLee-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:33:12 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:33:12 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-f04Eg_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:33:12 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:33:12 INFO - Running setup.py install for manifestparser 04:33:12 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:33:12 INFO - Running setup.py install for mozcrash 04:33:12 INFO - Running setup.py install for mozdebug 04:33:12 INFO - Running setup.py install for mozdevice 04:33:13 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:33:13 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:33:13 INFO - Running setup.py install for mozfile 04:33:13 INFO - Running setup.py install for mozhttpd 04:33:13 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:33:13 INFO - Running setup.py install for mozinfo 04:33:13 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:33:13 INFO - Running setup.py install for mozInstall 04:33:13 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:33:13 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:33:13 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:33:13 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:33:13 INFO - Running setup.py install for mozleak 04:33:13 INFO - Running setup.py install for mozlog 04:33:13 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:33:13 INFO - Running setup.py install for moznetwork 04:33:14 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:33:14 INFO - Running setup.py install for mozprocess 04:33:14 INFO - Running setup.py install for mozprofile 04:33:14 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:33:14 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:33:14 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:33:14 INFO - Running setup.py install for mozrunner 04:33:14 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:33:14 INFO - Running setup.py install for mozscreenshot 04:33:14 INFO - Running setup.py install for moztest 04:33:14 INFO - Running setup.py install for mozversion 04:33:15 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:33:15 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:33:15 INFO - Cleaning up... 04:33:15 INFO - Return code: 0 04:33:15 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:15 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:15 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:15 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:15 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:15 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:15 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 0x10895ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10895d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb23574340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108738d30>, '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 0x10865fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10872dbe8>, '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.YcbZMisP8l/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.9jhi2ST41v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:15 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:33:15 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:33:15 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcbZMisP8l/Render', 04:33:15 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:15 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:15 INFO - 'HOME': '/Users/cltbld', 04:33:15 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:15 INFO - 'LOGNAME': 'cltbld', 04:33:15 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:15 INFO - 'MOZ_NO_REMOTE': '1', 04:33:15 INFO - 'NO_EM_RESTART': '1', 04:33:15 INFO - 'PAGER': '/bin/cat', 04:33:15 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:15 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:15 INFO - 'PWD': '/builds/slave/test', 04:33:15 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:15 INFO - 'SHELL': '/bin/bash', 04:33:15 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9jhi2ST41v/Listeners', 04:33:15 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:33:15 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:15 INFO - 'USER': 'cltbld', 04:33:15 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:15 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:15 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:15 INFO - 'XPC_FLAGS': '0x0', 04:33:15 INFO - 'XPC_SERVICE_NAME': '0', 04:33:15 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:33:15 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-pUbWE5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:33:15 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-cdBJZF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:33:15 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-W9wUHn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:33:15 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-ohmTbP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:33:15 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-ouXo1C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:33:15 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-75KBjU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:33:15 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:33:15 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:33:15 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-2bKzAl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:33:16 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-ABpCcw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:33:16 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-RhylEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:33:16 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-62SPEL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:33:16 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-VrlNxY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:33:16 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-TdpIgr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:33:16 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-BWSUZM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:33:16 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-Mx3hAJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:16 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-fuwmGw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:33:16 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:33:16 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:33:16 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-MXLUBX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:33:17 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:33:17 INFO - Running setup.py (path:/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/pip-JLueWU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:33:17 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:33:17 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:19 INFO - Downloading blessings-1.6.tar.gz 04:33:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:33:19 INFO - Installing collected packages: blessings 04:33:19 INFO - Running setup.py install for blessings 04:33:20 INFO - Successfully installed blessings 04:33:20 INFO - Cleaning up... 04:33:20 INFO - Return code: 0 04:33:20 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:33:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:33:20 INFO - Reading from file tmpfile_stdout 04:33:20 INFO - Current package versions: 04:33:20 INFO - blessings == 1.6 04:33:20 INFO - blobuploader == 1.2.4 04:33:20 INFO - docopt == 0.6.1 04:33:20 INFO - functools32 == 3.2.3-2 04:33:20 INFO - jsonschema == 2.5.1 04:33:20 INFO - manifestparser == 1.1 04:33:20 INFO - mozInstall == 1.12 04:33:20 INFO - mozcrash == 1.0 04:33:20 INFO - mozdebug == 0.1 04:33:20 INFO - mozdevice == 0.49 04:33:20 INFO - mozfile == 1.2 04:33:20 INFO - mozhttpd == 0.7 04:33:20 INFO - mozinfo == 0.9 04:33:20 INFO - mozleak == 0.1 04:33:20 INFO - mozlog == 3.4 04:33:20 INFO - moznetwork == 0.27 04:33:20 INFO - mozprocess == 0.25 04:33:20 INFO - mozprofile == 0.28 04:33:20 INFO - mozrunner == 6.13 04:33:20 INFO - mozscreenshot == 0.1 04:33:20 INFO - mozsystemmonitor == 0.3 04:33:20 INFO - moztest == 0.8 04:33:20 INFO - mozversion == 1.4 04:33:20 INFO - psutil == 3.1.1 04:33:20 INFO - requests == 1.2.3 04:33:20 INFO - wsgiref == 0.1.2 04:33:20 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:20 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 0x10895ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10895d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb23574340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108738d30>, '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 0x10865fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10872dbe8>, '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.YcbZMisP8l/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.9jhi2ST41v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:33:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcbZMisP8l/Render', 04:33:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:20 INFO - 'HOME': '/Users/cltbld', 04:33:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:20 INFO - 'LOGNAME': 'cltbld', 04:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:20 INFO - 'MOZ_NO_REMOTE': '1', 04:33:20 INFO - 'NO_EM_RESTART': '1', 04:33:20 INFO - 'PAGER': '/bin/cat', 04:33:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:20 INFO - 'PWD': '/builds/slave/test', 04:33:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:20 INFO - 'SHELL': '/bin/bash', 04:33:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9jhi2ST41v/Listeners', 04:33:20 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:33:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:20 INFO - 'USER': 'cltbld', 04:33:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:20 INFO - 'XPC_FLAGS': '0x0', 04:33:20 INFO - 'XPC_SERVICE_NAME': '0', 04:33:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:33:20 INFO - Cleaning up... 04:33:20 INFO - Return code: 0 04:33:20 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:20 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 0x10895ab70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10895d768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbb23574340>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x108738d30>, '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 0x10865fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10872dbe8>, '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.YcbZMisP8l/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.9jhi2ST41v/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:33:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:33:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcbZMisP8l/Render', 04:33:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:20 INFO - 'HOME': '/Users/cltbld', 04:33:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:20 INFO - 'LOGNAME': 'cltbld', 04:33:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:20 INFO - 'MOZ_NO_REMOTE': '1', 04:33:20 INFO - 'NO_EM_RESTART': '1', 04:33:20 INFO - 'PAGER': '/bin/cat', 04:33:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:20 INFO - 'PWD': '/builds/slave/test', 04:33:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:20 INFO - 'SHELL': '/bin/bash', 04:33:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9jhi2ST41v/Listeners', 04:33:20 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:33:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:20 INFO - 'USER': 'cltbld', 04:33:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:20 INFO - 'XPC_FLAGS': '0x0', 04:33:20 INFO - 'XPC_SERVICE_NAME': '0', 04:33:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:20 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:33:20 INFO - Cleaning up... 04:33:20 INFO - Return code: 0 04:33:20 INFO - Running post-action listener: _resource_record_post_action 04:33:20 INFO - Running post-action listener: _start_resource_monitoring 04:33:21 INFO - Starting resource monitoring. 04:33:21 INFO - [mozharness: 2017-03-10 12:33:21.025011Z] Finished create-virtualenv step (success) 04:33:21 INFO - [mozharness: 2017-03-10 12:33:21.026110Z] Running install step. 04:33:21 INFO - Running pre-action listener: _resource_record_pre_action 04:33:21 INFO - Running main action method: install 04:33:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:33:21 INFO - Reading from file tmpfile_stdout 04:33:21 INFO - Detecting whether we're running mozinstall >=1.0... 04:33:21 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:33:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:33:21 INFO - Reading from file tmpfile_stdout 04:33:21 INFO - Output received: 04:33:21 INFO - Usage: mozinstall [options] installer 04:33:21 INFO - Options: 04:33:21 INFO - -h, --help show this help message and exit 04:33:21 INFO - -d DEST, --destination=DEST 04:33:21 INFO - Directory to install application into. [default: 04:33:21 INFO - "/builds/slave/test"] 04:33:21 INFO - --app=APP Application being installed. [default: firefox] 04:33:21 INFO - mkdir: /builds/slave/test/build/application 04:33:21 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'] 04:33:21 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 04:33:41 INFO - Reading from file tmpfile_stdout 04:33:41 INFO - Output received: 04:33:41 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:33:41 INFO - Running post-action listener: _resource_record_post_action 04:33:41 INFO - [mozharness: 2017-03-10 12:33:41.640141Z] Finished install step (success) 04:33:41 INFO - [mozharness: 2017-03-10 12:33:41.640277Z] Running run-tests step. 04:33:41 INFO - Running pre-action listener: _resource_record_pre_action 04:33:41 INFO - Running main action method: run_tests 04:33:41 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:33:41 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:33:41 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:33:41 INFO - 2017-03-10 04:33:41.654 screenresolution[1624:7458] starting screenresolution argv=screenresolution get 04:33:41 INFO - 2017-03-10 04:33:41.657 screenresolution[1624:7458] Display 0: 1600x1200x32@60 04:33:41 INFO - 2017-03-10 04:33:41.663 screenresolution[1625:7461] starting screenresolution argv=screenresolution list 04:33:41 INFO - Available Modes on Display 0 04:33:41 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:33:41 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:33:41 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:33:41 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:33:41 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:33:41 INFO - Intel Iris: 04:33:41 INFO - Chipset Model: Intel Iris 04:33:41 INFO - Type: GPU 04:33:41 INFO - Bus: Built-In 04:33:41 INFO - VRAM (Dynamic, Max): 1536 MB 04:33:41 INFO - Vendor: Intel (0x8086) 04:33:41 INFO - Device ID: 0x0a2e 04:33:41 INFO - Revision ID: 0x0009 04:33:41 INFO - Displays: 04:33:41 INFO - Display: 04:33:41 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:33:41 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:33:41 INFO - Display Serial Number: 1600x1200 60 04:33:41 INFO - Main Display: Yes 04:33:41 INFO - Mirror: Off 04:33:41 INFO - Online: Yes 04:33:41 INFO - Rotation: Supported 04:33:41 INFO - Return code: 0 04:33:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:33:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:33:41 INFO - Python 2.7.3 04:33:41 INFO - Return code: 0 04:33:41 INFO - grabbing minidump binary from tooltool 04:33:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:41 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 0x108738d30>, '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 0x10865fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10872dbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:33:41 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:33:41 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:33:41 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:33:41 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:33:42 INFO - Return code: 0 04:33:42 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:33:42 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:33:42 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:33:42 INFO - ENV: RUST_BACKTRACE is now 1 04:33:42 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:33:42 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:33:42 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/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0152', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:33:42 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/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0152 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:33:42 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.YcbZMisP8l/Render', 04:33:42 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:42 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:42 INFO - 'HOME': '/Users/cltbld', 04:33:42 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:42 INFO - 'LOGNAME': 'cltbld', 04:33:42 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:33:42 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:33:42 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:42 INFO - 'MOZ_NO_REMOTE': '1', 04:33:42 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:33:42 INFO - 'NO_EM_RESTART': '1', 04:33:42 INFO - 'PAGER': '/bin/cat', 04:33:42 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:42 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:42 INFO - 'PWD': '/builds/slave/test', 04:33:42 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:33:42 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:42 INFO - 'RUST_BACKTRACE': '1', 04:33:42 INFO - 'SHELL': '/bin/bash', 04:33:42 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.9jhi2ST41v/Listeners', 04:33:42 INFO - 'TMPDIR': '/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/', 04:33:42 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:42 INFO - 'USER': 'cltbld', 04:33:42 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:42 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:42 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:42 INFO - 'XPC_FLAGS': '0x0', 04:33:42 INFO - 'XPC_SERVICE_NAME': '0', 04:33:42 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:42 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/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0152', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:33:42 INFO - mozversion application_buildid: 20170310030521 04:33:42 INFO - mozversion application_changeset: 92c5b7bcd598c55f88979c014acfb79fd1ad7e45 04:33:42 INFO - mozversion application_display_name: Nightly 04:33:42 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:33:42 INFO - mozversion application_name: Firefox 04:33:42 INFO - mozversion application_remotingname: firefox 04:33:42 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:33:42 INFO - mozversion application_vendor: Mozilla 04:33:42 INFO - mozversion application_version: 55.0a1 04:33:42 INFO - mozversion platform_buildid: 20170310030521 04:33:42 INFO - mozversion platform_changeset: 92c5b7bcd598c55f88979c014acfb79fd1ad7e45 04:33:42 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:33:42 INFO - mozversion platform_version: 55.0a1 04:33:42 INFO - using testdate: 1489149222 04:33:42 INFO - actual date: 1489149222 04:33:42 INFO - starting webserver on 'localhost:49241' 04:33:42 INFO - SUITE-START | Running 2 tests 04:33:42 INFO - TEST-START | dromaeo_css 04:33:42 INFO - operating with platform_type : mac_ 04:33:42 INFO - Initialising browser for dromaeo_css test... 04:33:42 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpJm5jQt/profile http://localhost:49241/getInfo.html) 04:33:44 INFO - PROCESS | 1635 | __metrics Screen width/height:1600/1200 04:33:44 INFO - PROCESS | 1635 | colorDepth:24 04:33:44 INFO - PROCESS | 1635 | Browser inner width/height: 1024/689 04:33:44 INFO - PROCESS | 1635 | __metrics 04:33:45 INFO - PROCESS | 1635 | 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:33:45 INFO - PROCESS | 1635 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:33:45 INFO - TEST-INFO | 1635: exit 0 04:33:45 INFO - Browser initialized. 04:33:45 INFO - Running cycle 1/1 for dromaeo_css test... 04:33:45 INFO - TEST-INFO | started process 1637 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpJm5jQt/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:33:58 INFO - PROCESS | 1637 | RSS: Main: 232628224 04:33:58 INFO - PROCESS | 1637 | 04:37:02 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49241/tests/dromaeo/cssquery-ext.html) 04:37:04 INFO - PROCESS | 1637 | RSS: Main: 448249856 04:37:04 INFO - PROCESS | 1637 | 04:38:48 INFO - PROCESS | 1637 | ************************* 04:38:48 INFO - PROCESS | 1637 | A coding exception was thrown and uncaught in a Task. 04:38:48 INFO - PROCESS | 1637 | 04:38:48 ERROR - PROCESS | 1637 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:38:48 INFO - PROCESS | 1637 | Full stack: 04:38:48 INFO - PROCESS | 1637 | ************************* 04:40:08 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-ext.html (next: http://localhost:49241/tests/dromaeo/cssquery-jquery.html) 04:40:08 INFO - PROCESS | 1637 | RSS: Main: 365944832 04:40:08 INFO - PROCESS | 1637 | 04:43:11 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49241/tests/dromaeo/cssquery-mootools.html) 04:43:11 INFO - PROCESS | 1637 | RSS: Main: 355176448 04:43:11 INFO - PROCESS | 1637 | 04:46:14 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49241/tests/dromaeo/cssquery-prototype.html) 04:46:14 INFO - PROCESS | 1637 | RSS: Main: 358866944 04:46:14 INFO - PROCESS | 1637 | 04:49:18 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49241/tests/dromaeo/cssquery-yui.html) 04:49:19 INFO - PROCESS | 1637 | RSS: Main: 345387008 04:49:19 INFO - PROCESS | 1637 | 04:52:23 INFO - PROCESS | 1637 | Cycle 1(1): loaded http://localhost:49241/tests/dromaeo/cssquery-yui.html (next: http://localhost:49241/tests/dromaeo/cssquery-dojo.html) 04:52:23 INFO - PROCESS | 1637 | RSS: Main: 451112960 04:52:23 INFO - PROCESS | 1637 | 04:52:23 INFO - PROCESS | 1637 | __start_tp_report 04:52:23 INFO - PROCESS | 1637 | _x_x_mozilla_page_load 04:52:23 INFO - PROCESS | 1637 | _x_x_mozilla_page_load_details 04:52:23 INFO - PROCESS | 1637 | |i|pagename|runs| 04:52:23 INFO - PROCESS | 1637 | |0;dojo.html;2780.5968134620475;3365.8148801815896;3377.8817741379057;3412.641672624376;3442.896713098608;4759.357486739289;5847.678377689225;5888.528917686585;5972.701364931758;6017.037274036155;5905.20279762232;5954.970225148879;5990.131430942511;6033.215681961339;6045.758169673219;4794.208955522335;5234.293370395005;5343.545798607123;5353.03645343838;5364.812231571896;5403.081476149064;5454.147994316322;5456.208849716789;5463.863403414906;5507.201455788908;5229.08491014071;5262.815801446931;5315.7873685052555;5337.4662533746705;5366.597505187107;5336.839894803162;5357.8392648220615;5361.571074314045;5401.000814849226;5440.319960004999;5273.736313184364;5287.68273903567;5313.601479889024;5317.601179911522;5393.5954803389905;5743.626664266851;5772.769089236467;5960.642361458326;5984.880302393971;6015;6282;6290.245170579514;6291.433770960635;6296.118543403927;6308.463780578611;6253.843653908643;6265;6274.435300822948;6302;6319.304876463585;5890.705464726747;5954.910676339859;5965.403459654;5993.790217342415;5997.1304160896425;6336.429721325011;6337.809865704036;6342.016987366966;6351.650659213788;6358.23701155855;6279.717412716439;6296.905546416808;6337.112804207414;6347.143135676717;6372;6321.936780632135;6336.429721325103;6341.080543321193;6344.841378965562;6351;6225.501959843202;6263.404976527223;6297.842553936188;6302.338254483213;6310.432061114522;5354.196870469461;6212.47193988516;6303.180586523723;6306.3378345274;6315.084312774714;5040.319556859777;5040.31955685985;5045.142325804622;5046.62150338726;5057.266696329012;4414.381986521889;4459.955400446019;4460.955610992134;4519.118771839526;4553.203189441834;6000.459958603747;6065.120557519135;6140.048292514578;6140.201773769381;6142.508599312045;6378.330275321117;6387.393197646216;6390.4248617624635;6393.9360606394275;6406.583572067801;5977.820665380045;6070.0591408331775;6074.969625151846;6081.969590152021;6096;5473.31583552056;5512.3660779010925;5537.224788529609;5537.280153580009;5627.71861406928;6341.587796793194;6397.680115994275;6407.679616019181;6421.775237866652;6422.165118534561;6098.75604975796;6258.906116408167;6288.9685551573775;6294.276158241861;6321.11504389395;6556.3443655635965;6569.638669873203;6573.638449885111;6579;6580.8354791130605;6348.968255158695;6355.046742988588;6358.237011558643;6367.331430199948;6375.776847810304;6248.750049997949;6282.560220784501;6315.400036996478;6318.241810982528;6330.651814150082;6104.125697713769;6179.474744646755;6197.5351848610635;6203.193584834124;6210.534209934363;5185.611079169153;6170.290416602148;6215.906761398493;6304.432601065926;6314.273858506331;6173.074038894202;6192.349803270592;6209.410106039919;6218.129461875251;6225.501959843111;6289.056641503811;6307.779227727007;6311.147995020613;6320.747170113328;6322.083297921868;5934.406559344031;5973.193618861572;6038.426349496791;6186.597871138361;6190.226221722285 04:52:23 INFO - PROCESS | 1637 | |1;ext.html;642.1683919324475;747.7756672998103;781.9139894611593;840.3823189955382;858.7681326041973;25965.740342596568;27097.32256693581;27161.728382716192;38437.807810960905;38825.223495530074;38256.85229443114;38557.84326470203;38570.228595428074;38581.64964226253;38616.80691596545;8888.600012999414;9054.818903621923;9064.546772661373;9069.274458043374;9075.909240907573;7056.929430705704;7203.639818009105;7256.310650488195;8968.820623587524;9126.908730912706;7204.27957204278;7231;10734.624288149917;11021.779564408747;11055.834162487568;10714.571417143305;10754.462276886163;10760.515776789985;10766.300190487671;10782.137429005661;10428.322159059713;10509.737256568571;10512.52693628781;10524.36853788775;10533.157347412189;26222.34444138912;26679.733202667918;27426.040088596805;27427.31431714203;36832.81583592092;3139.5133754268127;3751.8311675974646;3799.9930018545106;3853.6339047790693;3974.3839704845795;26389.208323750318;26476.338091547866;26692.46615067688;26939.73060269392;27147.1855844323;3137.8431078445988;3169;3180.7614428917923;3237.077432931603;3260.5272235525954;349266;349839;354884;355513.22243388876;363253;48161.4246646568;48194.03611927742;48199.5180048202;48245.00447435102;48295.79260518445;42091.368629470584;42907.570924290354;44873.10253794906;49471.50528494741;50096.74951625219;14018.22899740524;14176.220307883166;14223.928880355532;14257.144571325754;14292.571222863331;11688.532458701557;11717.824232636518;11739.354335511458;11743;11771.058315334752;11635.01102406305;11680.532942986445;11707.121965852595;11795.587154449724;11837.763244735057;4506.2564676828615;5295.285136506599;5299.814506492255;5306.602004849652;5331.86670333237;1002.9197664186847;1055.8416237564272;1076.9946150269197;1103.1230172013268;1114.8662160540625;25119.62320565193;25211.243662690147;25802.74197258041;25806.870965645052;26040;1029.1509504658536;1045.9529321180564;1072.9248952573246;1220.2556440571245;1234.962951111468;12167.878321216675;13252.867471325357;13669.316534173251;13849.446022159202;14007.579772606838;399819;401662;402069;402230.98884505976;403424;49178.01643967101;49289.75355123273;49307.26039109416;49446.50553494419;49549.75225123923;1359.7212571422835;1404.6909679870412;1417.7377185220562;1423.1247782613618;1423.943042278318;25067.87466062658;25157.87421062883;26112.955481781275;26187.4762504745;26259.4748105033;41974.79012604917;41991.950201245214;42054.1589168221;42070.6343492526;42134;395815;396696;397369;398018;398832;29676.40647187001;30165.849170754005;30188.396232075676;30229.395412091195;30242.54636180503;37960;38684.226315474094;38922.80538597289;39005.414918776805;39169.804150979064;30777.153370797823;31157.376852463276;33206;33212.83393583017;33257.501137482475;31990.52014219835;32630.51054234141;32852.34295314032;32910.50634240536;33275.1681207962;32890.17774555655;35048;36163.638363616024;36251.81874090613;37254.44118338173;29086.98195563145;30160.3967920636;31530.211744706565;31842.52236216505;31882.20294492656;23918.52162956766;24099.51800963936;24242.63636045496;24380.87809560941;24564 04:52:23 INFO - PROCESS | 1637 | |2;jquery.html;379.6621007303499;391.751237963893;398.0923494432694;408.59957241902936;415.41841422009185;13534.458621655134;18140.183691733888;21886.343409697714;23132.190373336936;23244.767552324472;22101.226457074004;22311.665325020138;22788.923495328127;22836.20073297435;23102.191423300188;5183.559397451221;6426.196725409324;6655.423838103249;6827.897581536281;6828.385445309921;6641.402273795357;6763.898541521857;6812.931870681304;6830.897536536956;6835.974603809419;6483.448906842924;6645.269020407775;6683.064370988066;6685.966570167142;6728.663566821664;6464.321246269168;6678.065070890079;6685.899711504331;6766.188057433115;6767.898481522781;6558.508111891627;6570.671466426659;6571.44142747867;6580.638064906429;6588.176477940257;22115.889420552954;26190.69046547665;26633.46733065347;26886.462270754477;27017.594736078976;3351.379994700988;3362.6469220731715;3366.1584603849037;3366.461366181399;3376.9493457598155;15729.606759830982;15846.683066338725;16140.192990350435;16335.26491307894;16764.580885477837;1719.389616686071;1723.5346456456687;1965.4987978065644;1978.485593745622;2005;139659;141320;145198;150072;150325;16308.266128024268;20921.47696307574;21115.366539003855;21552.353429397142;21805;36225.45661815075;36345.636543634755;36408.72569460056;36452.08869778277;36580.26839463249;10629.309094908805;10650.68047958547;10689.786204275872;10779.191560632984;10893.945530272298;8577.914220857836;8592.656293748305;8619.051904290523;8742.344324175585;8811.162939520735;10474.633387831389;10569.70278331506;10574.947125264478;10681.732956676145;10721.892781072245;3505.2483800216705;3543.9291214175573;4089.959100408958;4124.340105583093;4136.379543068564;826.7437094500724;885.831691978522;912.5528491039342;930.9441433513875;1055.3773273768513;21857.890710546344;23277.418064548183;23566.764332356455;23583.174588889306;23649.763502365102;907.587047893207;909.1635695160468;925.3753716241511;929.9349045566745;937.8311903857235;11620.709482263012;12208.572699955459;12283.955863751682;12304.750713279092;12379.566715164927;572626;707437;711682;720879;723331;136097;140232;154876.22561887343;156235.21882390743;157906.21046894693;1234.8703386144505;1287.536486864728;1304.791233402651;1322.4049177869997;1368.9732700474644;18069;20238.976102389643;21532.130107100482;21920.45198870041;22184.33446996593;65055.34944650493;65798.01302980364;66319.68922020053;66473;66763;89615.31154065389;90619;91697.54151229201;93409.5329523348;93646.12707745943;12126.454309555915;12167.452464638935;12632.747345052863;12847.486100555872;13100.475980961037;13222.206667599974;13267.40296686632;14315.928420357832;14580.052296600687;14761;11659.125565582446;11830.46762895689;12221.69445763863;12326.630201093982;12346.506139754669;11556.41751057175;11732.472038758448;11881.881181188077;12082.818757718816;12153.878461215629;10122.993371136561;11411.144164187885;11833.467493962964;11923.403829808301;11940.52237910474;10626.89373106259;12538.310392928477;12846.35768211567;13144.60566183016;13151.34243287851;11694.532218711156;11850.407479626158;12074.879251207727;12176.756464870476;12177.512899484276 04:52:23 INFO - PROCESS | 1637 | |3;mootools.html;1494.7085318362924;1523.1470376589104;1542.460138951367;1547.5898886795;1553.4329969561109;10429.947850260747;10888;10916.945415272912;10918.290311129771;10963.50664220111;8677.305815534757;10793.02862742353;10980.450977451135;10989.725256868582;10992.230543861933;2315.730584027654;2350.5063936573256;2351.870647114408;2360.5042940982416;2360.752121027293;2292.793648571628;2327.185485080217;2328.1618617297845;2328.196772113618;2328.941776455585;2273.454370950976;2298.9425264368356;2299.4021554395895;2304.7234331880113;2307.457747429353;2254.4138523983884;2280.6350983842503;2281.6121259385945;2284.6001949658908;2284.7258329000624;1968.1438574220117;2226.788455096779;2302.412884714404;2304.8617082975074;2306.550222706573;10862.891371086267;10951;10957.56169753209;10967;10972.890271097347;5606.074997625427;5782.219400380936;5793.304803423574;5808.506276966463;5822.475977162076;3343.3981883261004;3489.70337521311;3596.8381422836037;3659.3779057560278;3662.5788034376124;1135.4606561883122;1138.618562781469;1195.5217912834935;1209.2260952990093;1231.9876801231962;13385.73228535424;13737.862621373759;14022.509212177627;15187.620309492351;15195;4212.85255016073;4321.114171594815;4322.891927701832;4328.458942632171;4328.696991210585;11136.220464567403;11403.885961140448;11534.19260651763;11534.884651153548;11536;5439.891202175934;5525.336959564878;5527.226188333637;5530.281063461724;5537.335519737577;4825.372701548847;5144.742762861842;5221.973890130525;5230.979958907977;5234.9476505235225;3614.8915532534065;3750.3811871041516;3784;3817.11053028747;3831.1379939513945;875.7965731855564;888.2139306713476;1021.7088129883097;1025.7999690060515;1035.8653375061194;683.9829004274933;792.3106896999648;814.1654803826126;816.3102178659024;823.6664151018847;6461.935380646228;6528.738850445929;6729.091572637729;6783.219929708147;6795.422389096883;930.330162283155;937.2689302344182;948.5921053946731;963.0706368354571;980.5293459139652;4172.958270417257;4504.211762941472;4505.977470112629;4551.3173024046655;4674.228752255908;12957.805632915513;13230.669233269053;13231.73536529264;13234.933825330812;13255.270960097094;11180.329180249211;12652.430640621194;13093.083484156017;13122.868771312356;13153.53962611304;9626.422414655142;9908.455034973145;9912.256580756328;9921.355111917703;9922.7023189303;6401.64790936503;6681.832954176184;6918.135233095863;6940.958856171615;6975.128108986377;11717.179797414099;12066.51733930668;12076.396180191132;12096.274223546616;12100;10118.494075296352;11074;12039.518419263131;12042.879571204176;12069.517219311128;9012.504312262889;9218.400803947721;9278.11857873501;9329.486878221764;9331.486768227542;8487.33404168695;10070.748231294276;10205.693829185137;10281.177505799667;10336.17310615164;9030.683926062557;9148.451092934445;9176;9243.075692430702;9356.625734970525;7685.269899359552;9005.369624126248;9068.909310906807;9150.176484116462;9186.954065229631;7806;7832.177621349676;7937.8412431752195;7962.522248665098;7965.80085497844;5808.564357673107;5885.588008839341;5988.970055149871;6064.636121832704;6067.423594758491;5913.349531551612;6041.456268935817;6070.6357618543025;6102.664353460602;6250.4374606285655 04:52:23 INFO - PROCESS | 1637 | |4;prototype.html;343.6855277421159;357.5673435143476;377.91119087014545;379.6014185105637;380.28316623165324;4184.184084103601;4885.482452634106;5021.522955319243;5021.844975655601;5030.3460550128475;4768.570828625432;4846.515348465152;4876.951230487694;4911.287863259825;4928;4061.5532291448067;4262.829486820523;4294.263990328419;4296.527381987995;4332.895111746516;3784;3795.5445346558313;3932.6067393260587;4172.311568591179;4346.261135606955;3788.3181027415053;3822.847086116552;4068.7151899367054;4186.9114030352175;4206.49522057352;3537.0096373015467;3718.7025037996896;4243.469566304212;4295.634871035965;4304.870853874389;3721.083641924411;3986.720929534934;4023.7384570002855;4135.31767258402;4136.420901073852;4256.978715106405;4361.82230797686;4545.818167273305;4840.6127509799135;4847.394075740533;3981.7411868228473;4435.624956263537;4970.4153840003;5010.7494625268955;5040.823571174991;4376.6498680105515;5333.733313334318;5357.81247656334;5374.650647707926;5417.6478528895495;3879.476270703447;4123.60825721556;4128.731632443882;4414.962483816301;4625.283081122431;5633.915491267634;5642.633228840113;5685.147227915804;5702.857428564319;5722.885542289173;4287.678424118141;4757.381540399726;4778.784954677048;4795.064962332382;4824.782884770124;4037.6164264394833;4257.680673949404;4355.7368363174955;4470.86587402372;4811.735354555463;4973.52751488608;4981.800727970841;4988.451270360258;4997.525235102659;4999.625028122905;4895.363602731622;5279.630425870229;5327.602578839537;5328.760205790749;5351.625386222927;1412.809270748436;1432.9211893345757;1445.6699836150767;1544.4285614322773;1657.6490160519138;1247.9625611231677;1291.3285091752425;1305.288617703354;1330.9068365214537;1339.6115126613172;4466.3747075409465;4852.733099679552;4875.317455556225;4999.0757255554945;5022.045811295842;4730.597899178609;5127.53852153308;5304.734763261821;5515.979543784413;5534.557235421156;3875.379939209713;4433.807658485885;4602.953970460319;4988.5260900214425;5008.64939454242;2472.357187131359;2611;2847.8860845565946;2850.5296626056884;2870.62681851358;5138.691678499302;5323.707196104174;5405.621526528315;5704.4295570443455;5726.4273572642405;5001.524855138756;5433.886053359052;5553.666779993213;5587.972060139673;5612.775488980476;5213.765380557884;5281.419043905167;5682.851518391514;5715.428057374198;5741.88516229673;4970.527799859007;5017.193810228242;5487.506124448819;5488.643238189505;5545.4490934170735;4161.417401563844;5409.6213265071065;5413.9729301353245;5462.481064298885;5517.613767036269;5034.496550344937;5135.279681306804;5517.138003397557;5769.884602308014;5808.6805225711305;4280.95719042818;4478.193925093515;4751.453582838018;4833.761379875562;4860;4647.442306923191;4780.521947805191;5241.397239317374;5307.956436771948;5341.198820177005;5180.663256888291;5301.920471193012;5374.731263436891;5381.685875073756;5406.4052954175795;5052.928299397229;5105.923411148761;5165.431802501646;5343.076492462788;5377;4463.8617152625875;4755.622188905547;4834.6374021947795;5067.442581316126;5220.843374698765;5323.441038690882;5337.893242135058;5365.570754339566;5377.300950876361;5413.26775431858;4422.889427764331;4434.37918691377;4518.356761294679;5265.420803711665;5294.576433885357 04:52:23 INFO - PROCESS | 1637 | |5;yui.html;758.2796343473701;776.4603600497653;778.9493682910611;810.6109067647533;839.236294971576;15352.692946141084;15531.611709707264;15544.222788860568;15573.532794016184;15607.687846243083;14227.857721422783;14385.496507622236;14398.49605263816;14408.855911440882;14412.49556265531;927.5733162745129;934.177923427383;979.1628157924979;982.052319511671;983.0709979069782;964.7009427077593;967.2310513142033;974.2352253481018;977.0864241933779;979.5053497983508;1028.346999655217;1030.2839526529065;1030.562011145264;1032.1536340201037;1033.4935881418126;1018.8522664213722;1021.8058568871891;1022.7698767777265;1023.22746326523;1025.021104844875;757.6401209425534;761.7981234972737;763.8548675751645;765.6822418696235;767.3745897093851;15833.76249356249;16208.75686864698;16235.18824058804;16288.429904953387;16546.58633534159;11778.941105294505;14683.192424416653;14716.632084197874;14734;14973.850261497464;11558.306501609846;11573.42132893352;11730.765384692259;12219.083568732382;12238.449269782792;3511.4030614795547;3681.337359275329;3781.9432708509394;3784.8864534064023;3800;91141.54429227878;108897;108957.45521272422;109064;112093;8222.301104406073;9227.307951903635;10987.560497580007;11472.598459053894;11486.483108260149;19216.327428540215;22858;23223.419414514436;23257.76742232556;23303.650445243336;7568.886466703004;7788.14330423653;7863;7874.606269686493;7909.169537198626;3538.5576802899636;4073.9796301018896;4290.806913688892;4291.163223171514;4450.5104438511735;3513.3675938331344;3618.222082252328;3619.8371073301764;3620.7827530348263;3623.148560088377;642.4956409218835;658.1805651963336;672.5393105722595;673.8315421144714;673.8416472129046;641.6118248459708;642.8813863876914;668.4618881800101;682.4165338635495;728.4318231779221;9666.613335466502;9725;10124.54439550222;10231.386116833013;10327.84508232377;633.4077637408946;654.257417830756;678.4656390780411;706.9540479868792;711.597947159853;4359;4834.709917404967;4849.199882019498;4854.490278520775;4892.706437613754;92608;106273.40589891003;107013;108113.29716757144;109241;92848.53575732079;94971;95325.61685957768;96000.51999739956;96946;59424.81150377055;81944;82006;83874.44860195887;84813.15186848052;7963.522188668699;9428.811423771349;9490.145886870216;9517.333786634868;9532.714018579454;32373.838130809196;52314.47685523248;52467.21299180439;53900.73049634727;54338.45661543492;57827.1325930103;60548.39451605428;68195.3180468189;69823.65088174527;71105.64447177731;11444.713882153013;11549.191556591293;11563.854084932125;12078.939605302268;12176.33030183313;12622.242665440102;12705.745885082062;12721.55474558386;12994.155379900276;13194.472221111047;10140.61306103807;10515.894841051797;11844.940775296069;11992.520299187934;12078.577249796215;11530.94234528822;11742.765144696887;12235;12243.69390765238;12448.377581121089;11575.189736718348;11588.072954163816;11710.00464960488;11827;12450.750984980068;9313.022132675971;9675.951620241854;9813.519233163202;10093.747656308651;10099.899001009895;7698.499597526143;9099.818003640023;9702.886878949324;9764.121229089416;9787.21702263803 04:52:23 INFO - PROCESS | 1637 | __end_tp_report 04:52:23 INFO - PROCESS | 1637 | __start_cc_report 04:52:23 INFO - PROCESS | 1637 | _x_x_mozilla_cycle_collect,2461 04:52:23 INFO - PROCESS | 1637 | __end_cc_report 04:52:23 INFO - PROCESS | 1637 | __startTimestamp1489150343532__endTimestamp 04:52:23 INFO - PROCESS | 1637 | 04:52:23 INFO - PROCESS | 1637 | ------- Summary: start ------- 04:52:23 INFO - PROCESS | 1637 | Number of tests: 6 04:52:23 INFO - PROCESS | 1637 | 04:52:23 INFO - PROCESS | 1637 | [#0] dojo.html Cycles:165 Average:5871.11 Median:6170.29 stddev:677.87 (11.0%) stddev-sans-first:635.12 04:52:23 INFO - PROCESS | 1637 | Values: 2780.6 3365.8 3377.9 3412.6 3442.9 4759.4 5847.7 5888.5 5972.7 6017.0 5905.2 5955.0 5990.1 6033.2 6045.8 4794.2 5234.3 5343.5 5353.0 5364.8 5403.1 5454.1 5456.2 5463.9 5507.2 5229.1 5262.8 5315.8 5337.5 5366.6 5336.8 5357.8 5361.6 5401.0 5440.3 5273.7 5287.7 5313.6 5317.6 5393.6 5743.6 5772.8 5960.6 5984.9 6015.0 6282.0 6290.2 6291.4 6296.1 6308.5 6253.8 6265.0 6274.4 6302.0 6319.3 5890.7 5954.9 5965.4 5993.8 5997.1 6336.4 6337.8 6342.0 6351.7 6358.2 6279.7 6296.9 6337.1 6347.1 6372.0 6321.9 6336.4 6341.1 6344.8 6351.0 6225.5 6263.4 6297.8 6302.3 6310.4 5354.2 6212.5 6303.2 6306.3 6315.1 5040.3 5040.3 5045.1 5046.6 5057.3 4414.4 4460.0 4461.0 4519.1 4553.2 6000.5 6065.1 6140.0 6140.2 6142.5 6378.3 6387.4 6390.4 6393.9 6406.6 5977.8 6070.1 6075.0 6082.0 6096.0 5473.3 5512.4 5537.2 5537.3 5627.7 6341.6 6397.7 6407.7 6421.8 6422.2 6098.8 6258.9 6289.0 6294.3 6321.1 6556.3 6569.6 6573.6 6579.0 6580.8 6349.0 6355.0 6358.2 6367.3 6375.8 6248.8 6282.6 6315.4 6318.2 6330.7 6104.1 6179.5 6197.5 6203.2 6210.5 5185.6 6170.3 6215.9 6304.4 6314.3 6173.1 6192.3 6209.4 6218.1 6225.5 6289.1 6307.8 6311.1 6320.7 6322.1 5934.4 5973.2 6038.4 6186.6 6190.2 04:52:23 INFO - PROCESS | 1637 | 04:52:23 INFO - PROCESS | 1637 | [#1] ext.html Cycles:180 Average:51554.20 Median:31936.36 stddev:101931.33 (319.2%) stddev-sans-first:102145.60 04:52:23 INFO - PROCESS | 1637 | Values: 642.2 747.8 781.9 840.4 858.8 25965.7 27097.3 27161.7 38437.8 38825.2 38256.9 38557.8 38570.2 38581.6 38616.8 8888.6 9054.8 9064.5 9069.3 9075.9 7056.9 7203.6 7256.3 8968.8 9126.9 7204.3 7231.0 10734.6 11021.8 11055.8 10714.6 10754.5 10760.5 10766.3 10782.1 10428.3 10509.7 10512.5 10524.4 10533.2 26222.3 26679.7 27426.0 27427.3 36832.8 3139.5 3751.8 3800.0 3853.6 3974.4 26389.2 26476.3 26692.5 26939.7 27147.2 3137.8 3169.0 3180.8 3237.1 3260.5 349266.0 349839.0 354884.0 355513.2 363253.0 48161.4 48194.0 48199.5 48245.0 48295.8 42091.4 42907.6 44873.1 49471.5 50096.7 14018.2 14176.2 14223.9 14257.1 14292.6 11688.5 11717.8 11739.4 11743.0 11771.1 11635.0 11680.5 11707.1 11795.6 11837.8 4506.3 5295.3 5299.8 5306.6 5331.9 1002.9 1055.8 1077.0 1103.1 1114.9 25119.6 25211.2 25802.7 25806.9 26040.0 1029.2 1046.0 1072.9 1220.3 1235.0 12167.9 13252.9 13669.3 13849.4 14007.6 399819.0 401662.0 402069.0 402231.0 403424.0 49178.0 49289.8 49307.3 49446.5 49549.8 1359.7 1404.7 1417.7 1423.1 1423.9 25067.9 25157.9 26113.0 26187.5 26259.5 41974.8 41992.0 42054.2 42070.6 42134.0 395815.0 396696.0 397369.0 398018.0 398832.0 29676.4 30165.8 30188.4 30229.4 30242.5 37960.0 38684.2 38922.8 39005.4 39169.8 30777.2 31157.4 33206.0 33212.8 33257.5 31990.5 32630.5 32852.3 32910.5 33275.2 32890.2 35048.0 36163.6 36251.8 37254.4 29087.0 30160.4 31530.2 31842.5 31882.2 23918.5 24099.5 24242.6 24380.9 24564.0 04:52:23 INFO - PROCESS | 1637 | 04:52:23 INFO - PROCESS | 1637 | [#2] jquery.html Cycles:180 Average:41640.84 Median:22150.11 stddev:115273.18 (520.4%) stddev-sans-first:115554.92 04:52:23 INFO - PROCESS | 1637 | Values: 379.7 391.8 398.1 408.6 415.4 13534.5 18140.2 21886.3 23132.2 23244.8 22101.2 22311.7 22788.9 22836.2 23102.2 5183.6 6426.2 6655.4 6827.9 6828.4 6641.4 6763.9 6812.9 6830.9 6836.0 6483.4 6645.3 6683.1 6686.0 6728.7 6464.3 6678.1 6685.9 6766.2 6767.9 6558.5 6570.7 6571.4 6580.6 6588.2 22115.9 26190.7 26633.5 26886.5 27017.6 3351.4 3362.6 3366.2 3366.5 3376.9 15729.6 15846.7 16140.2 16335.3 16764.6 1719.4 1723.5 1965.5 1978.5 2005.0 139659.0 141320.0 145198.0 150072.0 150325.0 16308.3 20921.5 21115.4 21552.4 21805.0 36225.5 36345.6 36408.7 36452.1 36580.3 10629.3 10650.7 10689.8 10779.2 10893.9 8577.9 8592.7 8619.1 8742.3 8811.2 10474.6 10569.7 10574.9 10681.7 10721.9 3505.2 3543.9 4090.0 4124.3 4136.4 826.7 885.8 912.6 930.9 1055.4 21857.9 23277.4 23566.8 23583.2 23649.8 907.6 909.2 925.4 929.9 937.8 11620.7 12208.6 12284.0 12304.8 12379.6 572626.0 707437.0 711682.0 720879.0 723331.0 136097.0 140232.0 154876.2 156235.2 157906.2 1234.9 1287.5 1304.8 1322.4 1369.0 18069.0 20239.0 21532.1 21920.5 22184.3 65055.3 65798.0 66319.7 66473.0 66763.0 89615.3 90619.0 91697.5 93409.5 93646.1 12126.5 12167.5 12632.7 12847.5 13100.5 13222.2 13267.4 14315.9 14580.1 14761.0 11659.1 11830.5 12221.7 12326.6 12346.5 11556.4 11732.5 11881.9 12082.8 12153.9 10123.0 11411.1 11833.5 11923.4 11940.5 10626.9 12538.3 12846.4 13144.6 13151.3 11694.5 11850.4 12074.9 12176.8 12177.5 04:52:23 INFO - PROCESS | 1637 | 04:52:23 INFO - PROCESS | 1637 | [#3] mootools.html Cycles:180 Average:6584.40 Median:3660.98 stddev:4058.61 (110.9%) stddev-sans-first:4051.98 04:52:23 INFO - PROCESS | 1637 | Values: 1494.7 1523.1 1542.5 1547.6 1553.4 10429.9 10888.0 10916.9 10918.3 10963.5 8677.3 10793.0 10980.5 10989.7 10992.2 2315.7 2350.5 2351.9 2360.5 2360.8 2292.8 2327.2 2328.2 2328.2 2328.9 2273.5 2298.9 2299.4 2304.7 2307.5 2254.4 2280.6 2281.6 2284.6 2284.7 1968.1 2226.8 2302.4 2304.9 2306.6 10862.9 10951.0 10957.6 10967.0 10972.9 5606.1 5782.2 5793.3 5808.5 5822.5 3343.4 3489.7 3596.8 3659.4 3662.6 1135.5 1138.6 1195.5 1209.2 1232.0 13385.7 13737.9 14022.5 15187.6 15195.0 4212.9 4321.1 4322.9 4328.5 4328.7 11136.2 11403.9 11534.2 11534.9 11536.0 5439.9 5525.3 5527.2 5530.3 5537.3 4825.4 5144.7 5222.0 5231.0 5234.9 3614.9 3750.4 3784.0 3817.1 3831.1 875.8 888.2 1021.7 1025.8 1035.9 684.0 792.3 814.2 816.3 823.7 6461.9 6528.7 6729.1 6783.2 6795.4 930.3 937.3 948.6 963.1 980.5 4173.0 4504.2 4506.0 4551.3 4674.2 12957.8 13230.7 13231.7 13234.9 13255.3 11180.3 12652.4 13093.1 13122.9 13153.5 9626.4 9908.5 9912.3 9921.4 9922.7 6401.6 6681.8 6918.1 6941.0 6975.1 11717.2 12066.5 12076.4 12096.3 12100.0 10118.5 11074.0 12039.5 12042.9 12069.5 9012.5 9218.4 9278.1 9329.5 9331.5 8487.3 10070.7 10205.7 10281.2 10336.2 9030.7 9148.5 9176.0 9243.1 9356.6 7685.3 9005.4 9068.9 9150.2 9187.0 7806.0 7832.2 7937.8 7962.5 7965.8 5808.6 5885.6 5989.0 6064.6 6067.4 5913.3 6041.5 6070.6 6102.7 6250.4 04:52:23 INFO - PROCESS | 1637 | 04:52:23 INFO - PROCESS | 1637 | [#4] prototype.html Cycles:180 Average:4495.30 Median:4867.66 stddev:1225.56 (25.2%) stddev-sans-first:1188.72 04:52:23 INFO - PROCESS | 1637 | Values: 343.7 357.6 377.9 379.6 380.3 4184.2 4885.5 5021.5 5021.8 5030.3 4768.6 4846.5 4877.0 4911.3 4928.0 4061.6 4262.8 4294.3 4296.5 4332.9 3784.0 3795.5 3932.6 4172.3 4346.3 3788.3 3822.8 4068.7 4186.9 4206.5 3537.0 3718.7 4243.5 4295.6 4304.9 3721.1 3986.7 4023.7 4135.3 4136.4 4257.0 4361.8 4545.8 4840.6 4847.4 3981.7 4435.6 4970.4 5010.7 5040.8 4376.6 5333.7 5357.8 5374.7 5417.6 3879.5 4123.6 4128.7 4415.0 4625.3 5633.9 5642.6 5685.1 5702.9 5722.9 4287.7 4757.4 4778.8 4795.1 4824.8 4037.6 4257.7 4355.7 4470.9 4811.7 4973.5 4981.8 4988.5 4997.5 4999.6 4895.4 5279.6 5327.6 5328.8 5351.6 1412.8 1432.9 1445.7 1544.4 1657.6 1248.0 1291.3 1305.3 1330.9 1339.6 4466.4 4852.7 4875.3 4999.1 5022.0 4730.6 5127.5 5304.7 5516.0 5534.6 3875.4 4433.8 4603.0 4988.5 5008.6 2472.4 2611.0 2847.9 2850.5 2870.6 5138.7 5323.7 5405.6 5704.4 5726.4 5001.5 5433.9 5553.7 5588.0 5612.8 5213.8 5281.4 5682.9 5715.4 5741.9 4970.5 5017.2 5487.5 5488.6 5545.4 4161.4 5409.6 5414.0 5462.5 5517.6 5034.5 5135.3 5517.1 5769.9 5808.7 4281.0 4478.2 4751.5 4833.8 4860.0 4647.4 4780.5 5241.4 5308.0 5341.2 5180.7 5301.9 5374.7 5381.7 5406.4 5052.9 5105.9 5165.4 5343.1 5377.0 4463.9 4755.6 4834.6 5067.4 5220.8 5323.4 5337.9 5365.6 5377.3 5413.3 4422.9 4434.4 4518.4 5265.4 5294.6 04:52:23 INFO - PROCESS | 1637 | 04:52:23 INFO - PROCESS | 1637 | [#5] yui.html Cycles:180 Average:20368.22 Median:3783.41 stddev:30056.39 (794.4%) stddev-sans-first:30104.64 04:52:23 INFO - PROCESS | 1637 | Values: 758.3 776.5 778.9 810.6 839.2 15352.7 15531.6 15544.2 15573.5 15607.7 14227.9 14385.5 14398.5 14408.9 14412.5 927.6 934.2 979.2 982.1 983.1 964.7 967.2 974.2 977.1 979.5 1028.3 1030.3 1030.6 1032.2 1033.5 1018.9 1021.8 1022.8 1023.2 1025.0 757.6 761.8 763.9 765.7 767.4 15833.8 16208.8 16235.2 16288.4 16546.6 11778.9 14683.2 14716.6 14734.0 14973.9 11558.3 11573.4 11730.8 12219.1 12238.4 3511.4 3681.3 3781.9 3784.9 3800.0 91141.5 108897.0 108957.5 109064.0 112093.0 8222.3 9227.3 10987.6 11472.6 11486.5 19216.3 22858.0 23223.4 23257.8 23303.7 7568.9 7788.1 7863.0 7874.6 7909.2 3538.6 4074.0 4290.8 4291.2 4450.5 3513.4 3618.2 3619.8 3620.8 3623.1 642.5 658.2 672.5 673.8 673.8 641.6 642.9 668.5 682.4 728.4 9666.6 9725.0 10124.5 10231.4 10327.8 633.4 654.3 678.5 707.0 711.6 4359.0 4834.7 4849.2 4854.5 4892.7 92608.0 106273.4 107013.0 108113.3 109241.0 92848.5 94971.0 95325.6 96000.5 96946.0 59424.8 81944.0 82006.0 83874.4 84813.2 7963.5 9428.8 9490.1 9517.3 9532.7 32373.8 52314.5 52467.2 53900.7 54338.5 57827.1 60548.4 68195.3 69823.7 71105.6 11444.7 11549.2 11563.9 12078.9 12176.3 12622.2 12705.7 12721.6 12994.2 13194.5 10140.6 10515.9 11844.9 11992.5 12078.6 11530.9 11742.8 12235.0 12243.7 12448.4 11575.2 11588.1 11710.0 11827.0 12450.8 9313.0 9676.0 9813.5 10093.7 10099.9 7698.5 9099.8 9702.9 9764.1 9787.2 04:52:23 INFO - PROCESS | 1637 | -------- Summary: end -------- 04:52:23 INFO - PROCESS | 1637 | 04:52:24 INFO - TEST-INFO | 1637: exit 0 04:52:24 INFO - TEST-OK | dromaeo_css | took 1121979ms 04:52:24 INFO - TEST-START | kraken 04:52:24 INFO - operating with platform_type : mac_ 04:52:24 INFO - Initialising browser for kraken test... 04:52:24 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpD_OHAx/profile http://localhost:49241/getInfo.html) 04:52:26 INFO - PROCESS | 1647 | __metrics Screen width/height:1600/1200 04:52:26 INFO - PROCESS | 1647 | colorDepth:24 04:52:26 INFO - PROCESS | 1647 | Browser inner width/height: 1024/689 04:52:26 INFO - PROCESS | 1647 | __metrics 04:52:26 INFO - PROCESS | 1647 | 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:52:26 INFO - PROCESS | 1647 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:52:27 INFO - TEST-INFO | 1647: exit 0 04:52:27 INFO - Browser initialized. 04:52:27 INFO - Running cycle 1/1 for kraken test... 04:52:27 INFO - TEST-INFO | started process 1648 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/T/tmpD_OHAx/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:52:39 INFO - PROCESS | 1648 | RSS: Main: 233926656 04:52:39 INFO - PROCESS | 1648 | 04:52:42 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection) 04:52:43 INFO - PROCESS | 1648 | RSS: Main: 284647424 04:52:43 INFO - PROCESS | 1648 | 04:52:46 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-dft) 04:52:46 INFO - PROCESS | 1648 | RSS: Main: 286363648 04:52:46 INFO - PROCESS | 1648 | 04:52:50 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-fft) 04:52:50 INFO - PROCESS | 1648 | RSS: Main: 378081280 04:52:50 INFO - PROCESS | 1648 | 04:52:52 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator) 04:52:53 INFO - PROCESS | 1648 | RSS: Main: 280645632 04:52:53 INFO - PROCESS | 1648 | 04:52:55 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:52:55 INFO - PROCESS | 1648 | RSS: Main: 283783168 04:52:55 INFO - PROCESS | 1648 | 04:52:58 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom) 04:52:59 INFO - PROCESS | 1648 | RSS: Main: 325124096 04:52:59 INFO - PROCESS | 1648 | 04:53:02 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate) 04:53:03 INFO - PROCESS | 1648 | RSS: Main: 329080832 04:53:03 INFO - PROCESS | 1648 | 04:53:06 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial) 04:53:06 INFO - PROCESS | 1648 | RSS: Main: 328597504 04:53:06 INFO - PROCESS | 1648 | 04:53:08 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:53:09 INFO - PROCESS | 1648 | RSS: Main: 302702592 04:53:09 INFO - PROCESS | 1648 | 04:53:10 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:53:11 INFO - PROCESS | 1648 | RSS: Main: 308547584 04:53:11 INFO - PROCESS | 1648 | 04:53:13 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:53:14 INFO - PROCESS | 1648 | RSS: Main: 310145024 04:53:14 INFO - PROCESS | 1648 | 04:53:17 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:53:18 INFO - PROCESS | 1648 | RSS: Main: 325861376 04:53:18 INFO - PROCESS | 1648 | 04:53:21 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:53:21 INFO - PROCESS | 1648 | RSS: Main: 319803392 04:53:21 INFO - PROCESS | 1648 | 04:53:23 INFO - PROCESS | 1648 | Cycle 1(1): loaded http://localhost:49241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49241/tests/kraken/driver.html?testName=ai-astar) 04:53:24 INFO - PROCESS | 1648 | RSS: Main: 364572672 04:53:24 INFO - PROCESS | 1648 | 04:53:24 INFO - PROCESS | 1648 | __start_tp_report 04:53:24 INFO - PROCESS | 1648 | _x_x_mozilla_page_load 04:53:24 INFO - PROCESS | 1648 | _x_x_mozilla_page_load_details 04:53:24 INFO - PROCESS | 1648 | |i|pagename|runs| 04:53:24 INFO - PROCESS | 1648 | |0;ai-astar;117;117;117;115;116;116;115;116;116;115 04:53:24 INFO - PROCESS | 1648 | |1;audio-beat-detection;132;113;109;148;111;115;135;137;129;113 04:53:24 INFO - PROCESS | 1648 | |2;audio-dft;186;186;188;183;182;184;185;188;187;186 04:53:24 INFO - PROCESS | 1648 | |3;audio-fft;79;61;61;95;66;59;60;62;79;63 04:53:24 INFO - PROCESS | 1648 | |4;audio-oscillator;85;71;88;70;70;68;84;69;69;84 04:53:24 INFO - PROCESS | 1648 | |5;imaging-gaussian-blur;89;87;88;88;88;87;88;88;87;87 04:53:24 INFO - PROCESS | 1648 | |6;imaging-darkroom;95;96;97;120;95;96;96;96;95;96 04:53:24 INFO - PROCESS | 1648 | |7;imaging-desaturate;106;137;129;84;87;83;84;86;88;132 04:53:24 INFO - PROCESS | 1648 | |8;json-parse-financial;65;62;62;62;63;63;64;63;62;64 04:53:24 INFO - PROCESS | 1648 | |9;json-stringify-tinderbox;58;62;61;66;60;58;59;59;59;60 04:53:24 INFO - PROCESS | 1648 | |10;stanford-crypto-aes;85;89;96;104;104;94;84;87;87;87 04:53:24 INFO - PROCESS | 1648 | |11;stanford-crypto-ccm;141;140;139;139;139;136;142;145;198;148 04:53:24 INFO - PROCESS | 1648 | |12;stanford-crypto-pbkdf2;169;171;170;169;168;169;170;148;175;230 04:53:24 INFO - PROCESS | 1648 | |13;stanford-crypto-sha256-iterative;87;79;72;64;67;67;66;65;77;74 04:53:24 INFO - PROCESS | 1648 | __end_tp_report 04:53:24 INFO - PROCESS | 1648 | __start_cc_report 04:53:24 INFO - PROCESS | 1648 | _x_x_mozilla_cycle_collect,2221 04:53:24 INFO - PROCESS | 1648 | __end_cc_report 04:53:24 INFO - PROCESS | 1648 | __startTimestamp1489150404018__endTimestamp 04:53:24 INFO - PROCESS | 1648 | 04:53:24 INFO - PROCESS | 1648 | ------- Summary: start ------- 04:53:24 INFO - PROCESS | 1648 | Number of tests: 14 04:53:24 INFO - PROCESS | 1648 | 04:53:24 INFO - PROCESS | 1648 | [#0] ai-astar Cycles:10 Average:116.00 Median:116.00 stddev:0.82 (0.7%) stddev-sans-first:0.78 04:53:24 INFO - PROCESS | 1648 | Values: 117.0 117.0 117.0 115.0 116.0 116.0 115.0 116.0 116.0 115.0 04:53:24 INFO - PROCESS | 1648 | 04:53:24 INFO - PROCESS | 1648 | [#1] audio-beat-detection Cycles:10 Average:124.20 Median:130.50 stddev:13.63 (10.4%) stddev-sans-first:14.16 04:53:24 INFO - PROCESS | 1648 | Values: 132.0 113.0 109.0 148.0 111.0 115.0 135.0 137.0 129.0 113.0 04:53:24 INFO - PROCESS | 1648 | 04:53:24 INFO - PROCESS | 1648 | [#2] audio-dft Cycles:10 Average:185.50 Median:186.00 stddev:2.01 (1.1%) stddev-sans-first:2.13 04:53:24 INFO - PROCESS | 1648 | Values: 186.0 186.0 188.0 183.0 182.0 184.0 185.0 188.0 187.0 186.0 04:53:24 INFO - PROCESS | 1648 | 04:53:24 INFO - PROCESS | 1648 | [#3] audio-fft Cycles:10 Average:68.50 Median:64.50 stddev:11.91 (18.5%) stddev-sans-first:12.01 04:53:24 INFO - PROCESS | 1648 | Values: 79.0 61.0 61.0 95.0 66.0 59.0 60.0 62.0 79.0 63.0 04:53:24 INFO - PROCESS | 1648 | 04:53:24 INFO - PROCESS | 1648 | [#4] audio-oscillator Cycles:10 Average:75.80 Median:77.50 stddev:8.24 (10.6%) stddev-sans-first:8.04 04:53:24 INFO - PROCESS | 1648 | Values: 85.0 71.0 88.0 70.0 70.0 68.0 84.0 69.0 69.0 84.0 04:53:24 INFO - PROCESS | 1648 | 04:53:24 INFO - PROCESS | 1648 | [#5] imaging-gaussian-blur Cycles:10 Average:87.70 Median:88.00 stddev:0.67 (0.8%) stddev-sans-first:0.53 04:53:24 INFO - PROCESS | 1648 | Values: 89.0 87.0 88.0 88.0 88.0 87.0 88.0 88.0 87.0 87.0 04:53:24 INFO - PROCESS | 1648 | 04:53:24 INFO - PROCESS | 1648 | [#6] imaging-darkroom Cycles:10 Average:98.20 Median:96.00 stddev:7.69 (8.0%) stddev-sans-first:8.06 04:53:24 INFO - PROCESS | 1648 | Values: 95.0 96.0 97.0 120.0 95.0 96.0 96.0 96.0 95.0 96.0 04:53:24 INFO - PROCESS | 1648 | 04:53:24 INFO - PROCESS | 1648 | [#7] imaging-desaturate Cycles:10 Average:101.60 Median:84.00 stddev:22.50 (26.8%) stddev-sans-first:23.80 04:53:24 INFO - PROCESS | 1648 | Values: 106.0 137.0 129.0 84.0 87.0 83.0 84.0 86.0 88.0 132.0 04:53:24 INFO - PROCESS | 1648 | 04:53:24 INFO - PROCESS | 1648 | [#8] json-parse-financial Cycles:10 Average:63.00 Median:63.00 stddev:1.05 (1.7%) stddev-sans-first:0.83 04:53:24 INFO - PROCESS | 1648 | Values: 65.0 62.0 62.0 62.0 63.0 63.0 64.0 63.0 62.0 64.0 04:53:24 INFO - PROCESS | 1648 | 04:53:24 INFO - PROCESS | 1648 | [#9] json-stringify-tinderbox Cycles:10 Average:60.20 Median:60.00 stddev:2.39 (4.0%) stddev-sans-first:2.40 04:53:24 INFO - PROCESS | 1648 | Values: 58.0 62.0 61.0 66.0 60.0 58.0 59.0 59.0 59.0 60.0 04:53:24 INFO - PROCESS | 1648 | 04:53:24 INFO - PROCESS | 1648 | [#10] stanford-crypto-aes Cycles:10 Average:91.70 Median:87.00 stddev:7.48 (8.6%) stddev-sans-first:7.54 04:53:24 INFO - PROCESS | 1648 | Values: 85.0 89.0 96.0 104.0 104.0 94.0 84.0 87.0 87.0 87.0 04:53:24 INFO - PROCESS | 1648 | 04:53:24 INFO - PROCESS | 1648 | [#11] stanford-crypto-ccm Cycles:10 Average:146.70 Median:141.50 stddev:18.34 (13.0%) stddev-sans-first:19.34 04:53:24 INFO - PROCESS | 1648 | Values: 141.0 140.0 139.0 139.0 139.0 136.0 142.0 145.0 198.0 148.0 04:53:24 INFO - PROCESS | 1648 | 04:53:24 INFO - PROCESS | 1648 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:173.90 Median:170.00 stddev:20.99 (12.3%) stddev-sans-first:22.19 04:53:24 INFO - PROCESS | 1648 | Values: 169.0 171.0 170.0 169.0 168.0 169.0 170.0 148.0 175.0 230.0 04:53:24 INFO - PROCESS | 1648 | 04:53:24 INFO - PROCESS | 1648 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:71.80 Median:73.00 stddev:7.47 (10.2%) stddev-sans-first:5.53 04:53:24 INFO - PROCESS | 1648 | Values: 87.0 79.0 72.0 64.0 67.0 67.0 66.0 65.0 77.0 74.0 04:53:24 INFO - PROCESS | 1648 | -------- Summary: end -------- 04:53:24 INFO - PROCESS | 1648 | 04:53:24 INFO - TEST-INFO | 1648: exit 0 04:53:24 INFO - TEST-OK | kraken | took 60722ms 04:53:24 INFO - SUITE-END | took 1182s 04:53:25 INFO - Completed test suite (00:19:42) 04:53:25 INFO - javascript benchmark 04:53:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7577.814133840199, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2780.5968134620475, 3365.8148801815896, 3377.8817741379057, 3412.641672624376, 3442.896713098608, 4759.357486739289, 5847.678377689225, 5888.528917686585, 5972.701364931758, 6017.037274036155, 5905.20279762232, 5954.970225148879, 5990.131430942511, 6033.215681961339, 6045.758169673219, 4794.208955522335, 5234.293370395005, 5343.545798607123, 5353.03645343838, 5364.812231571896, 5403.081476149064, 5454.147994316322, 5456.208849716789, 5463.863403414906, 5507.201455788908, 5229.08491014071, 5262.815801446931, 5315.7873685052555, 5337.4662533746705, 5366.597505187107, 5336.839894803162, 5357.8392648220615, 5361.571074314045, 5401.000814849226, 5440.319960004999, 5273.736313184364, 5287.68273903567, 5313.601479889024, 5317.601179911522, 5393.5954803389905, 5743.626664266851, 5772.769089236467, 5960.642361458326, 5984.880302393971, 6015.0, 6282.0, 6290.245170579514, 6291.433770960635, 6296.118543403927, 6308.463780578611, 6253.843653908643, 6265.0, 6274.435300822948, 6302.0, 6319.304876463585, 5890.705464726747, 5954.910676339859, 5965.403459654, 5993.790217342415, 5997.1304160896425, 6336.429721325011, 6337.809865704036, 6342.016987366966, 6351.650659213788, 6358.23701155855, 6279.717412716439, 6296.905546416808, 6337.112804207414, 6347.143135676717, 6372.0, 6321.936780632135, 6336.429721325103, 6341.080543321193, 6344.841378965562, 6351.0, 6225.501959843202, 6263.404976527223, 6297.842553936188, 6302.338254483213, 6310.432061114522, 5354.196870469461, 6212.47193988516, 6303.180586523723, 6306.3378345274, 6315.084312774714, 5040.319556859777, 5040.31955685985, 5045.142325804622, 5046.62150338726, 5057.266696329012, 4414.381986521889, 4459.955400446019, 4460.955610992134, 4519.118771839526, 4553.203189441834, 6000.459958603747, 6065.120557519135, 6140.048292514578, 6140.201773769381, 6142.508599312045, 6378.330275321117, 6387.393197646216, 6390.4248617624635, 6393.9360606394275, 6406.583572067801, 5977.820665380045, 6070.0591408331775, 6074.969625151846, 6081.969590152021, 6096.0, 5473.31583552056, 5512.3660779010925, 5537.224788529609, 5537.280153580009, 5627.71861406928, 6341.587796793194, 6397.680115994275, 6407.679616019181, 6421.775237866652, 6422.165118534561, 6098.75604975796, 6258.906116408167, 6288.9685551573775, 6294.276158241861, 6321.11504389395, 6556.3443655635965, 6569.638669873203, 6573.638449885111, 6579.0, 6580.8354791130605, 6348.968255158695, 6355.046742988588, 6358.237011558643, 6367.331430199948, 6375.776847810304, 6248.750049997949, 6282.560220784501, 6315.400036996478, 6318.241810982528, 6330.651814150082, 6104.125697713769, 6179.474744646755, 6197.5351848610635, 6203.193584834124, 6210.534209934363, 5185.611079169153, 6170.290416602148, 6215.906761398493, 6304.432601065926, 6314.273858506331, 6173.074038894202, 6192.349803270592, 6209.410106039919, 6218.129461875251, 6225.501959843111, 6289.056641503811, 6307.779227727007, 6311.147995020613, 6320.747170113328, 6322.083297921868, 5934.406559344031, 5973.193618861572, 6038.426349496791, 6186.597871138361, 6190.226221722285], "value": 5825.491894798592, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [642.1683919324475, 747.7756672998103, 781.9139894611593, 840.3823189955382, 858.7681326041973, 25965.740342596568, 27097.32256693581, 27161.728382716192, 38437.807810960905, 38825.223495530074, 38256.85229443114, 38557.84326470203, 38570.228595428074, 38581.64964226253, 38616.80691596545, 8888.600012999414, 9054.818903621923, 9064.546772661373, 9069.274458043374, 9075.909240907573, 7056.929430705704, 7203.639818009105, 7256.310650488195, 8968.820623587524, 9126.908730912706, 7204.27957204278, 7231.0, 10734.624288149917, 11021.779564408747, 11055.834162487568, 10714.571417143305, 10754.462276886163, 10760.515776789985, 10766.300190487671, 10782.137429005661, 10428.322159059713, 10509.737256568571, 10512.52693628781, 10524.36853788775, 10533.157347412189, 26222.34444138912, 26679.733202667918, 27426.040088596805, 27427.31431714203, 36832.81583592092, 3139.5133754268127, 3751.8311675974646, 3799.9930018545106, 3853.6339047790693, 3974.3839704845795, 26389.208323750318, 26476.338091547866, 26692.46615067688, 26939.73060269392, 27147.1855844323, 3137.8431078445988, 3169.0, 3180.7614428917923, 3237.077432931603, 3260.5272235525954, 349266.0, 349839.0, 354884.0, 355513.22243388876, 363253.0, 48161.4246646568, 48194.03611927742, 48199.5180048202, 48245.00447435102, 48295.79260518445, 42091.368629470584, 42907.570924290354, 44873.10253794906, 49471.50528494741, 50096.74951625219, 14018.22899740524, 14176.220307883166, 14223.928880355532, 14257.144571325754, 14292.571222863331, 11688.532458701557, 11717.824232636518, 11739.354335511458, 11743.0, 11771.058315334752, 11635.01102406305, 11680.532942986445, 11707.121965852595, 11795.587154449724, 11837.763244735057, 4506.2564676828615, 5295.285136506599, 5299.814506492255, 5306.602004849652, 5331.86670333237, 1002.9197664186847, 1055.8416237564272, 1076.9946150269197, 1103.1230172013268, 1114.8662160540625, 25119.62320565193, 25211.243662690147, 25802.74197258041, 25806.870965645052, 26040.0, 1029.1509504658536, 1045.9529321180564, 1072.9248952573246, 1220.2556440571245, 1234.962951111468, 12167.878321216675, 13252.867471325357, 13669.316534173251, 13849.446022159202, 14007.579772606838, 399819.0, 401662.0, 402069.0, 402230.98884505976, 403424.0, 49178.01643967101, 49289.75355123273, 49307.26039109416, 49446.50553494419, 49549.75225123923, 1359.7212571422835, 1404.6909679870412, 1417.7377185220562, 1423.1247782613618, 1423.943042278318, 25067.87466062658, 25157.87421062883, 26112.955481781275, 26187.4762504745, 26259.4748105033, 41974.79012604917, 41991.950201245214, 42054.1589168221, 42070.6343492526, 42134.0, 395815.0, 396696.0, 397369.0, 398018.0, 398832.0, 29676.40647187001, 30165.849170754005, 30188.396232075676, 30229.395412091195, 30242.54636180503, 37960.0, 38684.226315474094, 38922.80538597289, 39005.414918776805, 39169.804150979064, 30777.153370797823, 31157.376852463276, 33206.0, 33212.83393583017, 33257.501137482475, 31990.52014219835, 32630.51054234141, 32852.34295314032, 32910.50634240536, 33275.1681207962, 32890.17774555655, 35048.0, 36163.638363616024, 36251.81874090613, 37254.44118338173, 29086.98195563145, 30160.3967920636, 31530.211744706565, 31842.52236216505, 31882.20294492656, 23918.52162956766, 24099.51800963936, 24242.63636045496, 24380.87809560941, 24564.0], "value": 17698.216216485318, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.6621007303499, 391.751237963893, 398.0923494432694, 408.59957241902936, 415.41841422009185, 13534.458621655134, 18140.183691733888, 21886.343409697714, 23132.190373336936, 23244.767552324472, 22101.226457074004, 22311.665325020138, 22788.923495328127, 22836.20073297435, 23102.191423300188, 5183.559397451221, 6426.196725409324, 6655.423838103249, 6827.897581536281, 6828.385445309921, 6641.402273795357, 6763.898541521857, 6812.931870681304, 6830.897536536956, 6835.974603809419, 6483.448906842924, 6645.269020407775, 6683.064370988066, 6685.966570167142, 6728.663566821664, 6464.321246269168, 6678.065070890079, 6685.899711504331, 6766.188057433115, 6767.898481522781, 6558.508111891627, 6570.671466426659, 6571.44142747867, 6580.638064906429, 6588.176477940257, 22115.889420552954, 26190.69046547665, 26633.46733065347, 26886.462270754477, 27017.594736078976, 3351.379994700988, 3362.6469220731715, 3366.1584603849037, 3366.461366181399, 3376.9493457598155, 15729.606759830982, 15846.683066338725, 16140.192990350435, 16335.26491307894, 16764.580885477837, 1719.389616686071, 1723.5346456456687, 1965.4987978065644, 1978.485593745622, 2005.0, 139659.0, 141320.0, 145198.0, 150072.0, 150325.0, 16308.266128024268, 20921.47696307574, 21115.366539003855, 21552.353429397142, 21805.0, 36225.45661815075, 36345.636543634755, 36408.72569460056, 36452.08869778277, 36580.26839463249, 10629.309094908805, 10650.68047958547, 10689.786204275872, 10779.191560632984, 10893.945530272298, 8577.914220857836, 8592.656293748305, 8619.051904290523, 8742.344324175585, 8811.162939520735, 10474.633387831389, 10569.70278331506, 10574.947125264478, 10681.732956676145, 10721.892781072245, 3505.2483800216705, 3543.9291214175573, 4089.959100408958, 4124.340105583093, 4136.379543068564, 826.7437094500724, 885.831691978522, 912.5528491039342, 930.9441433513875, 1055.3773273768513, 21857.890710546344, 23277.418064548183, 23566.764332356455, 23583.174588889306, 23649.763502365102, 907.587047893207, 909.1635695160468, 925.3753716241511, 929.9349045566745, 937.8311903857235, 11620.709482263012, 12208.572699955459, 12283.955863751682, 12304.750713279092, 12379.566715164927, 572626.0, 707437.0, 711682.0, 720879.0, 723331.0, 136097.0, 140232.0, 154876.22561887343, 156235.21882390743, 157906.21046894693, 1234.8703386144505, 1287.536486864728, 1304.791233402651, 1322.4049177869997, 1368.9732700474644, 18069.0, 20238.976102389643, 21532.130107100482, 21920.45198870041, 22184.33446996593, 65055.34944650493, 65798.01302980364, 66319.68922020053, 66473.0, 66763.0, 89615.31154065389, 90619.0, 91697.54151229201, 93409.5329523348, 93646.12707745943, 12126.454309555915, 12167.452464638935, 12632.747345052863, 12847.486100555872, 13100.475980961037, 13222.206667599974, 13267.40296686632, 14315.928420357832, 14580.052296600687, 14761.0, 11659.125565582446, 11830.46762895689, 12221.69445763863, 12326.630201093982, 12346.506139754669, 11556.41751057175, 11732.472038758448, 11881.881181188077, 12082.818757718816, 12153.878461215629, 10122.993371136561, 11411.144164187885, 11833.467493962964, 11923.403829808301, 11940.52237910474, 10626.89373106259, 12538.310392928477, 12846.35768211567, 13144.60566183016, 13151.34243287851, 11694.532218711156, 11850.407479626158, 12074.879251207727, 12176.756464870476, 12177.512899484276], "value": 11837.211235249531, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1494.7085318362924, 1523.1470376589104, 1542.460138951367, 1547.5898886795, 1553.4329969561109, 10429.947850260747, 10888.0, 10916.945415272912, 10918.290311129771, 10963.50664220111, 8677.305815534757, 10793.02862742353, 10980.450977451135, 10989.725256868582, 10992.230543861933, 2315.730584027654, 2350.5063936573256, 2351.870647114408, 2360.5042940982416, 2360.752121027293, 2292.793648571628, 2327.185485080217, 2328.1618617297845, 2328.196772113618, 2328.941776455585, 2273.454370950976, 2298.9425264368356, 2299.4021554395895, 2304.7234331880113, 2307.457747429353, 2254.4138523983884, 2280.6350983842503, 2281.6121259385945, 2284.6001949658908, 2284.7258329000624, 1968.1438574220117, 2226.788455096779, 2302.412884714404, 2304.8617082975074, 2306.550222706573, 10862.891371086267, 10951.0, 10957.56169753209, 10967.0, 10972.890271097347, 5606.074997625427, 5782.219400380936, 5793.304803423574, 5808.506276966463, 5822.475977162076, 3343.3981883261004, 3489.70337521311, 3596.8381422836037, 3659.3779057560278, 3662.5788034376124, 1135.4606561883122, 1138.618562781469, 1195.5217912834935, 1209.2260952990093, 1231.9876801231962, 13385.73228535424, 13737.862621373759, 14022.509212177627, 15187.620309492351, 15195.0, 4212.85255016073, 4321.114171594815, 4322.891927701832, 4328.458942632171, 4328.696991210585, 11136.220464567403, 11403.885961140448, 11534.19260651763, 11534.884651153548, 11536.0, 5439.891202175934, 5525.336959564878, 5527.226188333637, 5530.281063461724, 5537.335519737577, 4825.372701548847, 5144.742762861842, 5221.973890130525, 5230.979958907977, 5234.9476505235225, 3614.8915532534065, 3750.3811871041516, 3784.0, 3817.11053028747, 3831.1379939513945, 875.7965731855564, 888.2139306713476, 1021.7088129883097, 1025.7999690060515, 1035.8653375061194, 683.9829004274933, 792.3106896999648, 814.1654803826126, 816.3102178659024, 823.6664151018847, 6461.935380646228, 6528.738850445929, 6729.091572637729, 6783.219929708147, 6795.422389096883, 930.330162283155, 937.2689302344182, 948.5921053946731, 963.0706368354571, 980.5293459139652, 4172.958270417257, 4504.211762941472, 4505.977470112629, 4551.3173024046655, 4674.228752255908, 12957.805632915513, 13230.669233269053, 13231.73536529264, 13234.933825330812, 13255.270960097094, 11180.329180249211, 12652.430640621194, 13093.083484156017, 13122.868771312356, 13153.53962611304, 9626.422414655142, 9908.455034973145, 9912.256580756328, 9921.355111917703, 9922.7023189303, 6401.64790936503, 6681.832954176184, 6918.135233095863, 6940.958856171615, 6975.128108986377, 11717.179797414099, 12066.51733930668, 12076.396180191132, 12096.274223546616, 12100.0, 10118.494075296352, 11074.0, 12039.518419263131, 12042.879571204176, 12069.517219311128, 9012.504312262889, 9218.400803947721, 9278.11857873501, 9329.486878221764, 9331.486768227542, 8487.33404168695, 10070.748231294276, 10205.693829185137, 10281.177505799667, 10336.17310615164, 9030.683926062557, 9148.451092934445, 9176.0, 9243.075692430702, 9356.625734970525, 7685.269899359552, 9005.369624126248, 9068.909310906807, 9150.176484116462, 9186.954065229631, 7806.0, 7832.177621349676, 7937.8412431752195, 7962.522248665098, 7965.80085497844, 5808.564357673107, 5885.588008839341, 5988.970055149871, 6064.636121832704, 6067.423594758491, 5913.349531551612, 6041.456268935817, 6070.6357618543025, 6102.664353460602, 6250.4374606285655], "value": 5007.76990849401, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [343.6855277421159, 357.5673435143476, 377.91119087014545, 379.6014185105637, 380.28316623165324, 4184.184084103601, 4885.482452634106, 5021.522955319243, 5021.844975655601, 5030.3460550128475, 4768.570828625432, 4846.515348465152, 4876.951230487694, 4911.287863259825, 4928.0, 4061.5532291448067, 4262.829486820523, 4294.263990328419, 4296.527381987995, 4332.895111746516, 3784.0, 3795.5445346558313, 3932.6067393260587, 4172.311568591179, 4346.261135606955, 3788.3181027415053, 3822.847086116552, 4068.7151899367054, 4186.9114030352175, 4206.49522057352, 3537.0096373015467, 3718.7025037996896, 4243.469566304212, 4295.634871035965, 4304.870853874389, 3721.083641924411, 3986.720929534934, 4023.7384570002855, 4135.31767258402, 4136.420901073852, 4256.978715106405, 4361.82230797686, 4545.818167273305, 4840.6127509799135, 4847.394075740533, 3981.7411868228473, 4435.624956263537, 4970.4153840003, 5010.7494625268955, 5040.823571174991, 4376.6498680105515, 5333.733313334318, 5357.81247656334, 5374.650647707926, 5417.6478528895495, 3879.476270703447, 4123.60825721556, 4128.731632443882, 4414.962483816301, 4625.283081122431, 5633.915491267634, 5642.633228840113, 5685.147227915804, 5702.857428564319, 5722.885542289173, 4287.678424118141, 4757.381540399726, 4778.784954677048, 4795.064962332382, 4824.782884770124, 4037.6164264394833, 4257.680673949404, 4355.7368363174955, 4470.86587402372, 4811.735354555463, 4973.52751488608, 4981.800727970841, 4988.451270360258, 4997.525235102659, 4999.625028122905, 4895.363602731622, 5279.630425870229, 5327.602578839537, 5328.760205790749, 5351.625386222927, 1412.809270748436, 1432.9211893345757, 1445.6699836150767, 1544.4285614322773, 1657.6490160519138, 1247.9625611231677, 1291.3285091752425, 1305.288617703354, 1330.9068365214537, 1339.6115126613172, 4466.3747075409465, 4852.733099679552, 4875.317455556225, 4999.0757255554945, 5022.045811295842, 4730.597899178609, 5127.53852153308, 5304.734763261821, 5515.979543784413, 5534.557235421156, 3875.379939209713, 4433.807658485885, 4602.953970460319, 4988.5260900214425, 5008.64939454242, 2472.357187131359, 2611.0, 2847.8860845565946, 2850.5296626056884, 2870.62681851358, 5138.691678499302, 5323.707196104174, 5405.621526528315, 5704.4295570443455, 5726.4273572642405, 5001.524855138756, 5433.886053359052, 5553.666779993213, 5587.972060139673, 5612.775488980476, 5213.765380557884, 5281.419043905167, 5682.851518391514, 5715.428057374198, 5741.88516229673, 4970.527799859007, 5017.193810228242, 5487.506124448819, 5488.643238189505, 5545.4490934170735, 4161.417401563844, 5409.6213265071065, 5413.9729301353245, 5462.481064298885, 5517.613767036269, 5034.496550344937, 5135.279681306804, 5517.138003397557, 5769.884602308014, 5808.6805225711305, 4280.95719042818, 4478.193925093515, 4751.453582838018, 4833.761379875562, 4860.0, 4647.442306923191, 4780.521947805191, 5241.397239317374, 5307.956436771948, 5341.198820177005, 5180.663256888291, 5301.920471193012, 5374.731263436891, 5381.685875073756, 5406.4052954175795, 5052.928299397229, 5105.923411148761, 5165.431802501646, 5343.076492462788, 5377.0, 4463.8617152625875, 4755.622188905547, 4834.6374021947795, 5067.442581316126, 5220.843374698765, 5323.441038690882, 5337.893242135058, 5365.570754339566, 5377.300950876361, 5413.26775431858, 4422.889427764331, 4434.37918691377, 4518.356761294679, 5265.420803711665, 5294.576433885357], "value": 4144.80331577305, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [758.2796343473701, 776.4603600497653, 778.9493682910611, 810.6109067647533, 839.236294971576, 15352.692946141084, 15531.611709707264, 15544.222788860568, 15573.532794016184, 15607.687846243083, 14227.857721422783, 14385.496507622236, 14398.49605263816, 14408.855911440882, 14412.49556265531, 927.5733162745129, 934.177923427383, 979.1628157924979, 982.052319511671, 983.0709979069782, 964.7009427077593, 967.2310513142033, 974.2352253481018, 977.0864241933779, 979.5053497983508, 1028.346999655217, 1030.2839526529065, 1030.562011145264, 1032.1536340201037, 1033.4935881418126, 1018.8522664213722, 1021.8058568871891, 1022.7698767777265, 1023.22746326523, 1025.021104844875, 757.6401209425534, 761.7981234972737, 763.8548675751645, 765.6822418696235, 767.3745897093851, 15833.76249356249, 16208.75686864698, 16235.18824058804, 16288.429904953387, 16546.58633534159, 11778.941105294505, 14683.192424416653, 14716.632084197874, 14734.0, 14973.850261497464, 11558.306501609846, 11573.42132893352, 11730.765384692259, 12219.083568732382, 12238.449269782792, 3511.4030614795547, 3681.337359275329, 3781.9432708509394, 3784.8864534064023, 3800.0, 91141.54429227878, 108897.0, 108957.45521272422, 109064.0, 112093.0, 8222.301104406073, 9227.307951903635, 10987.560497580007, 11472.598459053894, 11486.483108260149, 19216.327428540215, 22858.0, 23223.419414514436, 23257.76742232556, 23303.650445243336, 7568.886466703004, 7788.14330423653, 7863.0, 7874.606269686493, 7909.169537198626, 3538.5576802899636, 4073.9796301018896, 4290.806913688892, 4291.163223171514, 4450.5104438511735, 3513.3675938331344, 3618.222082252328, 3619.8371073301764, 3620.7827530348263, 3623.148560088377, 642.4956409218835, 658.1805651963336, 672.5393105722595, 673.8315421144714, 673.8416472129046, 641.6118248459708, 642.8813863876914, 668.4618881800101, 682.4165338635495, 728.4318231779221, 9666.613335466502, 9725.0, 10124.54439550222, 10231.386116833013, 10327.84508232377, 633.4077637408946, 654.257417830756, 678.4656390780411, 706.9540479868792, 711.597947159853, 4359.0, 4834.709917404967, 4849.199882019498, 4854.490278520775, 4892.706437613754, 92608.0, 106273.40589891003, 107013.0, 108113.29716757144, 109241.0, 92848.53575732079, 94971.0, 95325.61685957768, 96000.51999739956, 96946.0, 59424.81150377055, 81944.0, 82006.0, 83874.44860195887, 84813.15186848052, 7963.522188668699, 9428.811423771349, 9490.145886870216, 9517.333786634868, 9532.714018579454, 32373.838130809196, 52314.47685523248, 52467.21299180439, 53900.73049634727, 54338.45661543492, 57827.1325930103, 60548.39451605428, 68195.3180468189, 69823.65088174527, 71105.64447177731, 11444.713882153013, 11549.191556591293, 11563.854084932125, 12078.939605302268, 12176.33030183313, 12622.242665440102, 12705.745885082062, 12721.55474558386, 12994.155379900276, 13194.472221111047, 10140.61306103807, 10515.894841051797, 11844.940775296069, 11992.520299187934, 12078.577249796215, 11530.94234528822, 11742.765144696887, 12235.0, 12243.69390765238, 12448.377581121089, 11575.189736718348, 11588.072954163816, 11710.00464960488, 11827.0, 12450.750984980068, 9313.022132675971, 9675.951620241854, 9813.519233163202, 10093.747656308651, 10099.899001009895, 7698.499597526143, 9099.818003640023, 9702.886878949324, 9764.121229089416, 9787.21702263803], "value": 7474.160048033494, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1464.8000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [117.0, 117.0, 117.0, 115.0, 116.0, 116.0, 115.0, 116.0, 116.0, 115.0], "value": 116.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 113.0, 109.0, 148.0, 111.0, 115.0, 135.0, 137.0, 129.0, 113.0], "value": 124.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 188.0, 183.0, 182.0, 184.0, 185.0, 188.0, 187.0, 186.0], "value": 185.5, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 61.0, 61.0, 95.0, 66.0, 59.0, 60.0, 62.0, 79.0, 63.0], "value": 68.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 88.0, 70.0, 70.0, 68.0, 84.0, 69.0, 69.0, 84.0], "value": 75.8, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 87.0, 88.0, 88.0, 88.0, 87.0, 88.0, 88.0, 87.0, 87.0], "value": 87.7, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 97.0, 120.0, 95.0, 96.0, 96.0, 96.0, 95.0, 96.0], "value": 98.2, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [106.0, 137.0, 129.0, 84.0, 87.0, 83.0, 84.0, 86.0, 88.0, 132.0], "value": 101.6, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 62.0, 62.0, 62.0, 63.0, 63.0, 64.0, 63.0, 62.0, 64.0], "value": 63.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 62.0, 61.0, 66.0, 60.0, 58.0, 59.0, 59.0, 59.0, 60.0], "value": 60.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 89.0, 96.0, 104.0, 104.0, 94.0, 84.0, 87.0, 87.0, 87.0], "value": 91.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 140.0, 139.0, 139.0, 139.0, 136.0, 142.0, 145.0, 198.0, 148.0], "value": 146.7, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [169.0, 171.0, 170.0, 169.0, 168.0, 169.0, 170.0, 148.0, 175.0, 230.0], "value": 173.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 79.0, 72.0, 64.0, 67.0, 67.0, 66.0, 65.0, 77.0, 74.0], "value": 71.8, "unit": "score"}]}]} 04:53:25 INFO - Return code: 0 04:53:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:53:25 ERROR - # TBPL SUCCESS # 04:53:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:53:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:53:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:53:25 INFO - 2017-03-10 04:53:25.309 screenresolution[1652:10142] starting screenresolution argv=screenresolution get 04:53:25 INFO - 2017-03-10 04:53:25.313 screenresolution[1652:10142] Display 0: 1600x1200x32@60 04:53:25 INFO - 2017-03-10 04:53:25.320 screenresolution[1653:10145] starting screenresolution argv=screenresolution list 04:53:25 INFO - Available Modes on Display 0 04:53:25 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:53:25 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:53:25 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:53:25 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:53:25 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:53:25 INFO - Intel Iris: 04:53:25 INFO - Chipset Model: Intel Iris 04:53:25 INFO - Type: GPU 04:53:25 INFO - Bus: Built-In 04:53:25 INFO - VRAM (Dynamic, Max): 1536 MB 04:53:25 INFO - Vendor: Intel (0x8086) 04:53:25 INFO - Device ID: 0x0a2e 04:53:25 INFO - Revision ID: 0x0009 04:53:25 INFO - Displays: 04:53:25 INFO - Display: 04:53:25 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:53:25 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:53:25 INFO - Display Serial Number: 1600x1200 60 04:53:25 INFO - Main Display: Yes 04:53:25 INFO - Mirror: Off 04:53:25 INFO - Online: Yes 04:53:25 INFO - Rotation: Supported 04:53:25 INFO - Return code: 0 04:53:25 INFO - Running post-action listener: _resource_record_post_action 04:53:25 INFO - [mozharness: 2017-03-10 12:53:25.559061Z] Finished run-tests step (success) 04:53:25 INFO - Running post-run listener: _resource_record_post_run 04:53:25 INFO - Total resource usage - Wall time: 1204s; CPU: 54.0%; Read bytes: 39035904; Write bytes: 513040384; Read time: 379; Write time: 1803 04:53:25 INFO - TinderboxPrint: CPU usage
54.0% 04:53:25 INFO - TinderboxPrint: I/O read bytes / time
39,035,904 / 379 04:53:25 INFO - TinderboxPrint: I/O write bytes / time
513,040,384 / 1,803 04:53:25 INFO - TinderboxPrint: CPU idle
2,214.7 (46.0%) 04:53:25 INFO - TinderboxPrint: CPU system
958.9 (19.9%) 04:53:25 INFO - TinderboxPrint: CPU user
1,643.9 (34.1%) 04:53:25 INFO - TinderboxPrint: Swap in / out
248,778,752 / 0 04:53:25 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 203393536; Write bytes: 203270144; Read time: 15592; Write time: 441 04:53:25 INFO - run-tests - Wall time: 1184s; CPU: 54.0%; Read bytes: 37172224; Write bytes: 298981376; Read time: 356; Write time: 1323 04:53:26 INFO - Running post-run listener: _upload_blobber_files 04:53:26 INFO - Blob upload gear active. 04:53:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:53:26 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:53:26 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:53:26 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:53:26 INFO - (blobuploader) - INFO - Open directory for files ... 04:53:26 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:53:26 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:26 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:27 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:53:27 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:27 INFO - (blobuploader) - INFO - Done attempting. 04:53:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:53:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:53:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:28 INFO - (blobuploader) - INFO - Done attempting. 04:53:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:53:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:29 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:53:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:29 INFO - (blobuploader) - INFO - Done attempting. 04:53:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:53:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:53:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:53:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:53:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:53:31 INFO - (blobuploader) - INFO - Done attempting. 04:53:31 INFO - (blobuploader) - INFO - Iteration through files over. 04:53:31 INFO - Return code: 0 04:53:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:53:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:53:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfbecd8a1622ad56cbb42a7976d371f9863ed754776ea643faa917ec88e761047da8cad0cb9b03e75e15ed95d26c9ab233b8f7c3a77dff0665240df003566275", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6fc439a88ea5b80c018e38dd34e89fce00ffd6683114cbda722afa5f1ba55507c851801746ac1625a05511deada241d2c435a227e31d7a83620fddbc799fc3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fc477f36b1011e2a886d74a7c19ce32b2d4423af1c750dc2dbaac0b460a6149c0c4ca67549105bbcb0ad59bacca49d05506712531de11ccfb9a338d9faa672f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/255a3c827ad4b53b43f3218831f53264c84573ef116e3ac259aec23ce6f51c7fa4ef839aa7565788ff84feeef81aa5f1257e794421356e00dfba0b1d81ca32a1"} 04:53:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:53:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:53:31 INFO - Contents: 04:53:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/dfbecd8a1622ad56cbb42a7976d371f9863ed754776ea643faa917ec88e761047da8cad0cb9b03e75e15ed95d26c9ab233b8f7c3a77dff0665240df003566275", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6fc439a88ea5b80c018e38dd34e89fce00ffd6683114cbda722afa5f1ba55507c851801746ac1625a05511deada241d2c435a227e31d7a83620fddbc799fc3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fc477f36b1011e2a886d74a7c19ce32b2d4423af1c750dc2dbaac0b460a6149c0c4ca67549105bbcb0ad59bacca49d05506712531de11ccfb9a338d9faa672f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/255a3c827ad4b53b43f3218831f53264c84573ef116e3ac259aec23ce6f51c7fa4ef839aa7565788ff84feeef81aa5f1257e794421356e00dfba0b1d81ca32a1"} 04:53:31 INFO - Running post-run listener: copy_logs_to_upload_dir 04:53:31 INFO - Copying logs to upload dir... 04:53:31 INFO - mkdir: /builds/slave/test/build/upload/logs 04:53:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1287.422461 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 27 secs) (at 2017-03-10 04:53:31.617754) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 04:53:31.623355) ========= 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.YcbZMisP8l/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.9jhi2ST41v/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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/dfbecd8a1622ad56cbb42a7976d371f9863ed754776ea643faa917ec88e761047da8cad0cb9b03e75e15ed95d26c9ab233b8f7c3a77dff0665240df003566275", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6fc439a88ea5b80c018e38dd34e89fce00ffd6683114cbda722afa5f1ba55507c851801746ac1625a05511deada241d2c435a227e31d7a83620fddbc799fc3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fc477f36b1011e2a886d74a7c19ce32b2d4423af1c750dc2dbaac0b460a6149c0c4ca67549105bbcb0ad59bacca49d05506712531de11ccfb9a338d9faa672f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/255a3c827ad4b53b43f3218831f53264c84573ef116e3ac259aec23ce6f51c7fa4ef839aa7565788ff84feeef81aa5f1257e794421356e00dfba0b1d81ca32a1"} build_url:https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011023 build_url: 'https://queue.taskcluster.net/v1/task/DNWRl1FlTaeEcjRog7G8IA/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/dfbecd8a1622ad56cbb42a7976d371f9863ed754776ea643faa917ec88e761047da8cad0cb9b03e75e15ed95d26c9ab233b8f7c3a77dff0665240df003566275", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/f6fc439a88ea5b80c018e38dd34e89fce00ffd6683114cbda722afa5f1ba55507c851801746ac1625a05511deada241d2c435a227e31d7a83620fddbc799fc3a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/0fc477f36b1011e2a886d74a7c19ce32b2d4423af1c750dc2dbaac0b460a6149c0c4ca67549105bbcb0ad59bacca49d05506712531de11ccfb9a338d9faa672f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/255a3c827ad4b53b43f3218831f53264c84573ef116e3ac259aec23ce6f51c7fa4ef839aa7565788ff84feeef81aa5f1257e794421356e00dfba0b1d81ca32a1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-10 04:53:31.658505) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 04:53:31.658855) ========= 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.YcbZMisP8l/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.9jhi2ST41v/Listeners TMPDIR=/var/folders/x7/246bjm1d2c1fylzrbln074gc00000w/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.005201 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-10 04:53:31.707270) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 04:53:31.707582) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-10 04:53:31.707911) ========= ========= Total master_lag: 0.18 =========