builder: mozilla-beta_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0112 starttime: 1483418914.7 results: success (0) buildid: 20170102193119 builduid: 32ed6b619e0d4c14b34a0757813c7a7d revision: b40eb1f2db20c3e3052b6fb6d003870aca751934 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 20:48:34.703812) ========= master: http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-02 20:48:34.704235) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 20:48:34.704509) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-02 20:48:34.731602) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 20:48:34.732158) ========= 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.xsRqtn23Of/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.0osfaTwA9E/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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-01-02 20:48:34-- 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-01-02 20:48:35 (164 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.559190 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 20:48:35.320720) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 20:48:35.321089) ========= 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.xsRqtn23Of/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.0osfaTwA9E/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.026438 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 20:48:35.370990) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 20:48:35.371436) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b40eb1f2db20c3e3052b6fb6d003870aca751934 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo releases/mozilla-beta --rev b40eb1f2db20c3e3052b6fb6d003870aca751934 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xsRqtn23Of/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.0osfaTwA9E/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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-01-02 20:48:35,470 truncating revision to first 12 chars 2017-01-02 20:48:35,470 Setting DEBUG logging. 2017-01-02 20:48:35,470 attempt 1/10 2017-01-02 20:48:35,470 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-beta/b40eb1f2db20?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-02 20:48:36,136 unpacking tar archive at: mozilla-beta-b40eb1f2db20/testing/mozharness/ program finished with exit code 0 elapsedTime=0.944629 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 20:48:36.341317) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 20:48:36.341806) ========= script_repo_revision: b40eb1f2db20c3e3052b6fb6d003870aca751934 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-02 20:48:36.342390) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 20:48:36.342868) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-02 20:48:36.366204) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-01-02 20:48:36.366646) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 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', 'Mozilla-Beta', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Beta'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.xsRqtn23Of/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.0osfaTwA9E/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:48:36 INFO - MultiFileLogger online at 20170102 20:48:36 in /builds/slave/test 20:48:36 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Beta --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Beta 20:48:36 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 20:48:36 INFO - {'append_to_log': False, 20:48:36 INFO - 'base_work_dir': '/builds/slave/test', 20:48:36 INFO - 'blob_upload_branch': 'Mozilla-Beta', 20:48:36 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 20:48:36 INFO - 'branch': 'Mozilla-Beta', 20:48:36 INFO - 'buildbot_json_path': 'buildprops.json', 20:48:36 INFO - 'config_files': ('talos/mac_config.py',), 20:48:36 INFO - 'default_actions': ('clobber', 20:48:36 INFO - 'read-buildbot-config', 20:48:36 INFO - 'download-and-extract', 20:48:36 INFO - 'populate-webroot', 20:48:36 INFO - 'create-virtualenv', 20:48:36 INFO - 'install', 20:48:36 INFO - 'run-tests'), 20:48:36 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 20:48:36 INFO - 'download_minidump_stackwalk': True, 20:48:36 INFO - 'download_symbols': 'ondemand', 20:48:36 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 20:48:36 INFO - 'tooltool.py': '/tools/tooltool.py', 20:48:36 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 20:48:36 INFO - '/tools/misc-python/virtualenv.py')}, 20:48:36 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 20:48:36 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 20:48:36 INFO - 'installer_path': 'installer.exe', 20:48:36 INFO - 'log_level': 'info', 20:48:36 INFO - 'log_name': 'talos', 20:48:36 INFO - 'log_to_console': True, 20:48:36 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 20:48:36 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 20:48:36 INFO - 'opt_config_files': (), 20:48:36 INFO - 'pip_index': False, 20:48:36 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:48:36 INFO - 'cmd': ('bash', 20:48:36 INFO - '-c', 20:48:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:48:36 INFO - 'enabled': True, 20:48:36 INFO - 'halt_on_failure': False, 20:48:36 INFO - 'name': 'check_screen_resolution'},), 20:48:36 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 20:48:36 INFO - 'cmd': ('bash', 20:48:36 INFO - '-c', 20:48:36 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 20:48:36 INFO - 'enabled': True, 20:48:36 INFO - 'halt_on_failure': False, 20:48:36 INFO - 'name': 'check_screen_resolution'},), 20:48:36 INFO - 'run_cmd_checks_enabled': True, 20:48:36 INFO - 'sps_profile': False, 20:48:36 INFO - 'sps_profile_interval': 0, 20:48:36 INFO - 'suite': 'dromaeojs', 20:48:36 INFO - 'system_bits': '32', 20:48:36 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 20:48:36 INFO - 'title': 't-yosemite-r7-0112', 20:48:36 INFO - 'tooltool_cache': '/builds/tooltool_cache', 20:48:36 INFO - 'use_talos_json': True, 20:48:36 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 20:48:36 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 20:48:36 INFO - 'work_dir': 'build'} 20:48:36 INFO - [mozharness: 2017-01-03 04:48:36.570175Z] Running clobber step. 20:48:36 INFO - Running pre-action listener: _resource_record_pre_action 20:48:36 INFO - Running main action method: clobber 20:48:36 INFO - rmtree: /builds/slave/test/build 20:48:36 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 20:48:38 INFO - Running post-action listener: _resource_record_post_action 20:48:38 INFO - [mozharness: 2017-01-03 04:48:38.956432Z] Finished clobber step (success) 20:48:38 INFO - [mozharness: 2017-01-03 04:48:38.956552Z] Running read-buildbot-config step. 20:48:38 INFO - Running pre-action listener: _resource_record_pre_action 20:48:38 INFO - Running main action method: read_buildbot_config 20:48:38 INFO - Using buildbot properties: 20:48:38 INFO - { 20:48:38 INFO - "project": "", 20:48:38 INFO - "product": "firefox", 20:48:38 INFO - "script_repo_revision": "production", 20:48:38 INFO - "builddir": "mozilla-beta_yosemite_r7_test-dromaeojs", 20:48:38 INFO - "repository": "", 20:48:38 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-beta talos dromaeojs", 20:48:38 INFO - "buildid": "20170102193119", 20:48:38 INFO - "pgo_build": "False", 20:48:38 INFO - "basedir": "/builds/slave/test", 20:48:38 INFO - "buildnumber": 5, 20:48:38 INFO - "slavename": "t-yosemite-r7-0112", 20:48:38 INFO - "master": "http://buildbot-master108.bb.releng.scl3.mozilla.com:8201/", 20:48:38 INFO - "platform": "yosemite_r7", 20:48:38 INFO - "scheduler": "tests-mozilla-beta-macosx64-talos", 20:48:38 INFO - "branch": "mozilla-beta", 20:48:38 INFO - "repo_path": "releases/mozilla-beta", 20:48:38 INFO - "revision": "b40eb1f2db20c3e3052b6fb6d003870aca751934", 20:48:38 INFO - "stage_platform": "macosx64", 20:48:38 INFO - "builduid": "32ed6b619e0d4c14b34a0757813c7a7d", 20:48:38 INFO - "slavebuilddir": "test" 20:48:38 INFO - } 20:48:38 INFO - Found installer url https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.dmg. 20:48:38 INFO - Running post-action listener: _resource_record_post_action 20:48:38 INFO - [mozharness: 2017-01-03 04:48:38.959849Z] Finished read-buildbot-config step (success) 20:48:38 INFO - [mozharness: 2017-01-03 04:48:38.959960Z] Running download-and-extract step. 20:48:38 INFO - Running pre-action listener: _resource_record_pre_action 20:48:38 INFO - Running main action method: download_and_extract 20:48:38 INFO - mkdir: /builds/slave/test/build/tests 20:48:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:48:38 INFO - trying https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json 20:48:38 INFO - Downloading https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 20:48:38 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json'}, attempt #1 20:48:39 INFO - Downloaded 1165 bytes. 20:48:39 INFO - Reading from file /builds/slave/test/build/firefox-51.0.en-US.mac.test_packages.json 20:48:39 INFO - Using the following test package requirements: 20:48:39 INFO - {u'common': [u'firefox-51.0.en-US.mac.common.tests.zip'], 20:48:39 INFO - u'cppunittest': [u'firefox-51.0.en-US.mac.common.tests.zip', 20:48:39 INFO - u'firefox-51.0.en-US.mac.cppunittest.tests.zip'], 20:48:39 INFO - u'gtest': [u'firefox-51.0.en-US.mac.common.tests.zip', 20:48:39 INFO - u'firefox-51.0.en-US.mac.gtest.tests.zip'], 20:48:39 INFO - u'jittest': [u'firefox-51.0.en-US.mac.common.tests.zip', u'jsshell-mac.zip'], 20:48:39 INFO - u'mochitest': [u'firefox-51.0.en-US.mac.common.tests.zip', 20:48:39 INFO - u'firefox-51.0.en-US.mac.mochitest.tests.zip'], 20:48:39 INFO - u'mozbase': [u'firefox-51.0.en-US.mac.common.tests.zip'], 20:48:39 INFO - u'reftest': [u'firefox-51.0.en-US.mac.common.tests.zip', 20:48:39 INFO - u'firefox-51.0.en-US.mac.reftest.tests.zip'], 20:48:39 INFO - u'talos': [u'firefox-51.0.en-US.mac.common.tests.zip', 20:48:39 INFO - u'firefox-51.0.en-US.mac.talos.tests.zip'], 20:48:39 INFO - u'web-platform': [u'firefox-51.0.en-US.mac.common.tests.zip', 20:48:39 INFO - u'firefox-51.0.en-US.mac.web-platform.tests.zip'], 20:48:39 INFO - u'xpcshell': [u'firefox-51.0.en-US.mac.common.tests.zip', 20:48:39 INFO - u'firefox-51.0.en-US.mac.xpcshell.tests.zip']} 20:48:39 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip'] for test suite category: common 20:48:39 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 20:48:39 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 20:48:39 INFO - Fetch https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 20:48:40 INFO - Expected file size: 16234589 20:48:47 INFO - Downloading packages: [u'firefox-51.0.en-US.mac.common.tests.zip', u'firefox-51.0.en-US.mac.talos.tests.zip'] for test suite category: talos 20:48:47 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip 20:48:47 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip'}, attempt #1 20:48:47 INFO - Fetch https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.common.tests.zip into memory 20:48:47 INFO - Expected file size: 16234589 20:48:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip 20:48:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip'}, attempt #1 20:48:54 INFO - Fetch https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.talos.tests.zip into memory 20:48:55 INFO - Expected file size: 14414089 20:48:55 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')]} 20:48:55 INFO - trying https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 20:48:55 INFO - Downloading https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.dmg to /builds/slave/test/build/firefox-51.0.en-US.mac.dmg 20:48:55 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg'}, attempt #1 20:48:58 INFO - Downloaded 86086418 bytes. 20:48:58 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 20:48:58 INFO - mkdir: /builds/slave/test/properties 20:48:58 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 20:48:58 INFO - Writing to file /builds/slave/test/properties/build_url 20:48:58 INFO - Contents: 20:48:58 INFO - build_url:https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.dmg 20:48:58 INFO - Running post-action listener: _resource_record_post_action 20:48:58 INFO - Running post-action listener: set_extra_try_arguments 20:48:58 INFO - [mozharness: 2017-01-03 04:48:58.568327Z] Finished download-and-extract step (success) 20:48:58 INFO - [mozharness: 2017-01-03 04:48:58.568449Z] Running populate-webroot step. 20:48:58 INFO - Running pre-action listener: _resource_record_pre_action 20:48:58 INFO - Running main action method: populate_webroot 20:48:58 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 20:48:58 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 20:48:58 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 20:48:58 INFO - '--tppagecycles', 20:48:58 INFO - '7'], 20:48:58 INFO - 'tests': ['tsvgm']}}, 20:48:58 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 20:48:58 INFO - 'tests': ['tresize', 'tcanvasmark']}, 20:48:58 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 20:48:58 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 20:48:58 INFO - 'tests': ['dromaeo_css', 'kraken']}, 20:48:58 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 20:48:58 INFO - 'g1': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:58 INFO - 'talos_options': ['--disable-e10s'], 20:48:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:48:58 INFO - 'g1-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:58 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 20:48:58 INFO - 'g2': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:58 INFO - 'talos_options': ['--disable-e10s'], 20:48:58 INFO - 'tests': ['damp', 'tps']}, 20:48:58 INFO - 'g2-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:58 INFO - 'tests': ['damp', 'tps']}, 20:48:58 INFO - 'g3': {'talos_options': ['--disable-e10s'], 20:48:58 INFO - 'tests': ['dromaeo_dom']}, 20:48:58 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 20:48:58 INFO - 'g4': {'talos_options': ['--disable-e10s'], 20:48:58 INFO - 'tests': ['basic_compositor_video']}, 20:48:58 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 20:48:58 INFO - 'other': {'talos_options': ['--disable-e10s'], 20:48:58 INFO - 'tests': ['a11yr', 20:48:58 INFO - 'ts_paint', 20:48:58 INFO - 'tpaint', 20:48:58 INFO - 'sessionrestore', 20:48:58 INFO - 'sessionrestore_no_auto_restore', 20:48:58 INFO - 'tabpaint']}, 20:48:58 INFO - 'other-e10s': {'tests': ['a11yr', 20:48:58 INFO - 'ts_paint', 20:48:58 INFO - 'tpaint', 20:48:58 INFO - 'sessionrestore', 20:48:58 INFO - 'sessionrestore_no_auto_restore', 20:48:58 INFO - 'tabpaint']}, 20:48:58 INFO - 'other-e10s_l64': {'tests': ['a11yr', 20:48:58 INFO - 'ts_paint', 20:48:58 INFO - 'tpaint', 20:48:58 INFO - 'sessionrestore', 20:48:58 INFO - 'sessionrestore_no_auto_restore', 20:48:58 INFO - 'tabpaint']}, 20:48:58 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 20:48:58 INFO - 'ts_paint', 20:48:58 INFO - 'tpaint', 20:48:58 INFO - 'sessionrestore', 20:48:58 INFO - 'sessionrestore_no_auto_restore', 20:48:58 INFO - 'tabpaint']}, 20:48:58 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 20:48:58 INFO - 'tests': ['a11yr', 20:48:58 INFO - 'ts_paint', 20:48:58 INFO - 'tpaint', 20:48:58 INFO - 'sessionrestore', 20:48:58 INFO - 'sessionrestore_no_auto_restore', 20:48:58 INFO - 'tabpaint']}, 20:48:58 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 20:48:58 INFO - 'tests': ['a11yr', 20:48:58 INFO - 'ts_paint', 20:48:58 INFO - 'tpaint', 20:48:58 INFO - 'sessionrestore', 20:48:58 INFO - 'sessionrestore_no_auto_restore', 20:48:58 INFO - 'tabpaint']}, 20:48:58 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 20:48:58 INFO - 'tests': ['tsvgx', 20:48:58 INFO - 'tsvgr_opacity', 20:48:58 INFO - 'tart', 20:48:58 INFO - 'tscrollx', 20:48:58 INFO - 'cart']}, 20:48:58 INFO - 'svgr-e10s': {'tests': ['tsvgx', 20:48:58 INFO - 'tsvgr_opacity', 20:48:58 INFO - 'tart', 20:48:58 INFO - 'tscrollx', 20:48:58 INFO - 'cart']}, 20:48:58 INFO - 'tp5o': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:58 INFO - 'talos_options': ['--disable-e10s'], 20:48:58 INFO - 'tests': ['tp5o']}, 20:48:58 INFO - 'tp5o-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:58 INFO - 'tests': ['tp5o']}, 20:48:58 INFO - 'xperf': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:58 INFO - 'talos_options': ['--disable-e10s', 20:48:58 INFO - '--xperf_path', 20:48:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:48:58 INFO - 'tests': ['tp5n']}, 20:48:58 INFO - 'xperf-e10s': {'pagesets_url': 'http://talos-bundles.pvt.build.mozilla.org/zips/tp5n.zip', 20:48:58 INFO - 'talos_options': ['--xperf_path', 20:48:58 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 20:48:58 INFO - 'tests': ['tp5n']}}, 20:48:58 INFO - 'talos.zip': {'path': '', 20:48:58 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 20:48:58 INFO - Running post-action listener: _resource_record_post_action 20:48:58 INFO - [mozharness: 2017-01-03 04:48:58.587485Z] Finished populate-webroot step (success) 20:48:58 INFO - [mozharness: 2017-01-03 04:48:58.587606Z] Running create-virtualenv step. 20:48:58 INFO - Running pre-action listener: _resource_record_pre_action 20:48:58 INFO - Running main action method: create_virtualenv 20:48:58 INFO - Creating virtualenv /builds/slave/test/build/venv 20:48:58 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 20:48:58 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 20:48:58 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 20:48:58 INFO - Using real prefix '/tools/python27' 20:48:58 INFO - New python executable in /builds/slave/test/build/venv/bin/python 20:48:59 INFO - Installing distribute.............................................................................................................................................................................................done. 20:49:02 INFO - Installing pip.................done. 20:49:02 INFO - Return code: 0 20:49:02 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 20:49:02 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')]} 20:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:02 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')]} 20:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:02 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2b34a83d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.xsRqtn23Of/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.0osfaTwA9E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:49:02 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 20:49:02 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 20:49:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xsRqtn23Of/Render', 20:49:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:49:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:49:02 INFO - 'HOME': '/Users/cltbld', 20:49:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:49:02 INFO - 'LOGNAME': 'cltbld', 20:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:02 INFO - 'MOZ_NO_REMOTE': '1', 20:49:02 INFO - 'NO_EM_RESTART': '1', 20:49:02 INFO - 'PAGER': '/bin/cat', 20:49:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:49:02 INFO - 'PWD': '/builds/slave/test', 20:49:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:49:02 INFO - 'SHELL': '/bin/bash', 20:49:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0osfaTwA9E/Listeners', 20:49:02 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:49:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:49:02 INFO - 'USER': 'cltbld', 20:49:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:49:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:02 INFO - 'XPC_FLAGS': '0x0', 20:49:02 INFO - 'XPC_SERVICE_NAME': '0', 20:49:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:02 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 20:49:02 INFO - Cleaning up... 20:49:02 INFO - Return code: 0 20:49:02 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 20:49:02 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')]} 20:49:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:02 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')]} 20:49:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:02 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2b34a83d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.xsRqtn23Of/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.0osfaTwA9E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:49:02 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 20:49:02 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 20:49:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xsRqtn23Of/Render', 20:49:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:49:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:49:02 INFO - 'HOME': '/Users/cltbld', 20:49:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:49:02 INFO - 'LOGNAME': 'cltbld', 20:49:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:02 INFO - 'MOZ_NO_REMOTE': '1', 20:49:02 INFO - 'NO_EM_RESTART': '1', 20:49:02 INFO - 'PAGER': '/bin/cat', 20:49:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:49:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:49:02 INFO - 'PWD': '/builds/slave/test', 20:49:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:49:02 INFO - 'SHELL': '/bin/bash', 20:49:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0osfaTwA9E/Listeners', 20:49:02 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:49:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:49:02 INFO - 'USER': 'cltbld', 20:49:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:49:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:49:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:02 INFO - 'XPC_FLAGS': '0x0', 20:49:02 INFO - 'XPC_SERVICE_NAME': '0', 20:49:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:49:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:02 INFO - Downloading/unpacking psutil>=3.1.1 20:49:02 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 20:49:02 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 20:49:02 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 20:49:02 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 20:49:02 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 20:49:02 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 20:49:06 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 20:49:06 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:49:06 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:49:06 INFO - Installing collected packages: psutil 20:49:06 INFO - Running setup.py install for psutil 20:49:06 INFO - building 'psutil._psutil_osx' extension 20:49:06 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 20:49:07 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 20:49:07 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 20:49:07 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 20:49:07 INFO - building 'psutil._psutil_posix' extension 20:49:07 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 20:49:07 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 20:49:07 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 20:49:07 INFO - ^ 20:49:07 INFO - 1 warning generated. 20:49:07 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 20:49:07 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 20:49:07 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 20:49:07 INFO - Successfully installed psutil 20:49:07 INFO - Cleaning up... 20:49:07 INFO - Return code: 0 20:49:07 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 20:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:49:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:07 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:49:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:07 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2b34a83d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.xsRqtn23Of/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.0osfaTwA9E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:49:07 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 20:49:07 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 20:49:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xsRqtn23Of/Render', 20:49:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:49:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:49:07 INFO - 'HOME': '/Users/cltbld', 20:49:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:49:07 INFO - 'LOGNAME': 'cltbld', 20:49:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:07 INFO - 'MOZ_NO_REMOTE': '1', 20:49:07 INFO - 'NO_EM_RESTART': '1', 20:49:07 INFO - 'PAGER': '/bin/cat', 20:49:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:49:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:49:07 INFO - 'PWD': '/builds/slave/test', 20:49:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:49:07 INFO - 'SHELL': '/bin/bash', 20:49:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0osfaTwA9E/Listeners', 20:49:07 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:49:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:49:07 INFO - 'USER': 'cltbld', 20:49:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:49:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:49:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:07 INFO - 'XPC_FLAGS': '0x0', 20:49:07 INFO - 'XPC_SERVICE_NAME': '0', 20:49:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:49:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:08 INFO - Downloading/unpacking mozsystemmonitor==0.3 20:49: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 20:49: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 20:49: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 20:49: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 20:49: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 20:49: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 20:49:10 INFO - Downloading mozsystemmonitor-0.3.tar.gz 20:49:10 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 20:49:10 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 20:49:10 INFO - Installing collected packages: mozsystemmonitor 20:49:10 INFO - Running setup.py install for mozsystemmonitor 20:49:10 INFO - Successfully installed mozsystemmonitor 20:49:10 INFO - Cleaning up... 20:49:10 INFO - Return code: 0 20:49:10 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 20:49: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')]} 20:49:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49: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')]} 20:49:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:10 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2b34a83d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.xsRqtn23Of/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.0osfaTwA9E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:49:10 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 20:49:10 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 20:49:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xsRqtn23Of/Render', 20:49:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:49:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:49:10 INFO - 'HOME': '/Users/cltbld', 20:49:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:49:10 INFO - 'LOGNAME': 'cltbld', 20:49:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:10 INFO - 'MOZ_NO_REMOTE': '1', 20:49:10 INFO - 'NO_EM_RESTART': '1', 20:49:10 INFO - 'PAGER': '/bin/cat', 20:49:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:49:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:49:10 INFO - 'PWD': '/builds/slave/test', 20:49:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:49:10 INFO - 'SHELL': '/bin/bash', 20:49:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0osfaTwA9E/Listeners', 20:49:10 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:49:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:49:10 INFO - 'USER': 'cltbld', 20:49:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:49:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:49:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:10 INFO - 'XPC_FLAGS': '0x0', 20:49:10 INFO - 'XPC_SERVICE_NAME': '0', 20:49:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:49:11 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:11 INFO - Downloading/unpacking jsonschema==2.5.1 20:49:11 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 20:49:11 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 20:49:11 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 20:49:11 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 20:49:11 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 20:49:11 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 20:49:13 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 20:49:13 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 20:49:13 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 20:49:13 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 20:49:13 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 20:49:13 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 20:49:13 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 20:49:13 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 20:49:14 INFO - Downloading functools32-3.2.3-2.tar.gz 20:49:14 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 20:49:14 INFO - warning: no files found matching '*.txt' 20:49:14 INFO - no previously-included directories found matching 'build' 20:49:14 INFO - no previously-included directories found matching 'dist' 20:49:14 INFO - no previously-included directories found matching '.git*' 20:49:14 INFO - Installing collected packages: jsonschema, functools32 20:49:14 INFO - Running setup.py install for functools32 20:49:14 INFO - warning: no files found matching '*.txt' 20:49:14 INFO - no previously-included directories found matching 'build' 20:49:14 INFO - no previously-included directories found matching 'dist' 20:49:14 INFO - no previously-included directories found matching '.git*' 20:49:14 INFO - Successfully installed jsonschema functools32 20:49:14 INFO - Cleaning up... 20:49:14 INFO - Return code: 0 20:49:14 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 20:49:14 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')]} 20:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:14 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')]} 20:49:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:14 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2b34a83d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.xsRqtn23Of/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.0osfaTwA9E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:49:14 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 20:49:14 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 20:49:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xsRqtn23Of/Render', 20:49:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:49:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:49:14 INFO - 'HOME': '/Users/cltbld', 20:49:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:49:14 INFO - 'LOGNAME': 'cltbld', 20:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:14 INFO - 'MOZ_NO_REMOTE': '1', 20:49:14 INFO - 'NO_EM_RESTART': '1', 20:49:14 INFO - 'PAGER': '/bin/cat', 20:49:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:49:14 INFO - 'PWD': '/builds/slave/test', 20:49:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:49:14 INFO - 'SHELL': '/bin/bash', 20:49:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0osfaTwA9E/Listeners', 20:49:14 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:49:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:49:14 INFO - 'USER': 'cltbld', 20:49:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:49:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:14 INFO - 'XPC_FLAGS': '0x0', 20:49:14 INFO - 'XPC_SERVICE_NAME': '0', 20:49:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:49:14 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:14 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 20:49:14 INFO - Cleaning up... 20:49:14 INFO - Return code: 0 20:49:14 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 20:49:14 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')]} 20:49:14 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:14 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:14 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')]} 20:49:14 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:14 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:14 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2b34a83d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.xsRqtn23Of/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.0osfaTwA9E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:49:14 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 20:49:14 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 20:49:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xsRqtn23Of/Render', 20:49:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:49:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:49:14 INFO - 'HOME': '/Users/cltbld', 20:49:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:49:14 INFO - 'LOGNAME': 'cltbld', 20:49:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:14 INFO - 'MOZ_NO_REMOTE': '1', 20:49:14 INFO - 'NO_EM_RESTART': '1', 20:49:14 INFO - 'PAGER': '/bin/cat', 20:49:14 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:49:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:49:14 INFO - 'PWD': '/builds/slave/test', 20:49:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:49:14 INFO - 'SHELL': '/bin/bash', 20:49:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0osfaTwA9E/Listeners', 20:49:14 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:49:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:49:14 INFO - 'USER': 'cltbld', 20:49:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:49:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:49:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:14 INFO - 'XPC_FLAGS': '0x0', 20:49:14 INFO - 'XPC_SERVICE_NAME': '0', 20:49:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:49:15 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:15 INFO - Downloading/unpacking blobuploader==1.2.4 20:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:49:15 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:49:15 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 20:49:15 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 20:49:15 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 20:49:17 INFO - Downloading blobuploader-1.2.4.tar.gz 20:49:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 20:49:17 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 20:49: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 20:49: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 20:49: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 20:49: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 20:49: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 20:49: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 20:49:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 20:49:18 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 20:49:18 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 20:49:18 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 20:49:18 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 20:49:18 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 20:49:18 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 20:49:18 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 20:49:18 INFO - Downloading docopt-0.6.1.tar.gz 20:49:18 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 20:49:19 INFO - Installing collected packages: blobuploader, requests, docopt 20:49:19 INFO - Running setup.py install for blobuploader 20:49:19 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 20:49:19 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 20:49:19 INFO - Running setup.py install for requests 20:49:19 INFO - Running setup.py install for docopt 20:49:19 INFO - Successfully installed blobuploader requests docopt 20:49:19 INFO - Cleaning up... 20:49:19 INFO - Return code: 0 20:49:19 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:49:19 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:19 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:19 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:49:19 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:19 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:19 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2b34a83d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.xsRqtn23Of/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.0osfaTwA9E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:49:19 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 20:49:19 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 20:49:19 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xsRqtn23Of/Render', 20:49:19 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:49:19 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:49:19 INFO - 'HOME': '/Users/cltbld', 20:49:19 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:49:19 INFO - 'LOGNAME': 'cltbld', 20:49:19 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:19 INFO - 'MOZ_NO_REMOTE': '1', 20:49:19 INFO - 'NO_EM_RESTART': '1', 20:49:19 INFO - 'PAGER': '/bin/cat', 20:49:19 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:49:19 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:49:19 INFO - 'PWD': '/builds/slave/test', 20:49:19 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:49:19 INFO - 'SHELL': '/bin/bash', 20:49:19 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0osfaTwA9E/Listeners', 20:49:19 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:49:19 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:49:19 INFO - 'USER': 'cltbld', 20:49:19 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:49:19 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:49:19 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:19 INFO - 'XPC_FLAGS': '0x0', 20:49:19 INFO - 'XPC_SERVICE_NAME': '0', 20:49:19 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:49:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:49:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-BrzkDE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:49:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Yiq9z9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:49:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-dchaKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:49:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-NpEn18-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:49:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-U88yAh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:49:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-vNPDXz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:49:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-1ewCTb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:49:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-NDQR_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:49:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:49:20 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-YTFuYk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:49:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-g8B0m8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:49:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-0EefHY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:49:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-e5jaqx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:49:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-eqquOF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:49:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-dPkHAX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:49:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-Mb5vxs-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:49:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-tU2GSb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:49:21 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:49:21 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-sJqJsI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:49:21 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 20:49:21 INFO - Running setup.py install for manifestparser 20:49:22 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 20:49:22 INFO - Running setup.py install for mozcrash 20:49:22 INFO - Running setup.py install for mozdebug 20:49:22 INFO - Running setup.py install for mozdevice 20:49:22 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 20:49:22 INFO - Installing dm script to /builds/slave/test/build/venv/bin 20:49:22 INFO - Running setup.py install for mozfile 20:49:22 INFO - Running setup.py install for mozhttpd 20:49:22 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 20:49:22 INFO - Running setup.py install for mozinfo 20:49:22 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 20:49:22 INFO - Running setup.py install for mozInstall 20:49:23 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 20:49:23 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 20:49:23 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 20:49:23 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 20:49:23 INFO - Running setup.py install for mozleak 20:49:23 INFO - Running setup.py install for mozlog 20:49:23 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 20:49:23 INFO - Running setup.py install for moznetwork 20:49:23 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 20:49:23 INFO - Running setup.py install for mozprocess 20:49:23 INFO - Running setup.py install for mozprofile 20:49:23 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 20:49:23 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 20:49:23 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 20:49:23 INFO - Running setup.py install for mozrunner 20:49:23 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 20:49:24 INFO - Running setup.py install for mozscreenshot 20:49:24 INFO - Running setup.py install for moztest 20:49:24 INFO - Running setup.py install for mozversion 20:49:24 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 20:49:24 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 20:49:24 INFO - Cleaning up... 20:49:24 INFO - Return code: 0 20:49:24 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:49:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:49:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:24 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2b34a83d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.xsRqtn23Of/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.0osfaTwA9E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:49:24 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 20:49:24 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 20:49:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xsRqtn23Of/Render', 20:49:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:49:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:49:24 INFO - 'HOME': '/Users/cltbld', 20:49:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:49:24 INFO - 'LOGNAME': 'cltbld', 20:49:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:24 INFO - 'MOZ_NO_REMOTE': '1', 20:49:24 INFO - 'NO_EM_RESTART': '1', 20:49:24 INFO - 'PAGER': '/bin/cat', 20:49:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:49:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:49:24 INFO - 'PWD': '/builds/slave/test', 20:49:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:49:24 INFO - 'SHELL': '/bin/bash', 20:49:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0osfaTwA9E/Listeners', 20:49:24 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:49:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:49:24 INFO - 'USER': 'cltbld', 20:49:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:49:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:49:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:24 INFO - 'XPC_FLAGS': '0x0', 20:49:24 INFO - 'XPC_SERVICE_NAME': '0', 20:49:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:49:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 20:49:24 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-FJauyq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 20:49:24 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)) 20:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 20:49:24 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-68XcWG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 20:49:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==0.17 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)) 20:49:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 20:49:24 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-lgAZcJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 20:49:25 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)) 20:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 20:49:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-e8IEyy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 20:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.48 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)) 20:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 20:49:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-sEo7Y2-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 20:49:25 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)) 20:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 20:49:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-I6NoH9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 20:49:25 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)) 20:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 20:49:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-MTuBGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 20:49:25 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)) 20:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 20:49:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-XOE0Hq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 20:49:25 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)) 20:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 20:49:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-WLPpX5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 20:49:25 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)) 20:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 20:49:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-bghq3x-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 20:49:25 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)) 20:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 20:49:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-OiDG14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 20:49:25 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)) 20:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 20:49:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-5Jjymc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 20:49:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.23 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)) 20:49:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 20:49:25 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-kmFxAr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 20:49:26 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)) 20:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 20:49:26 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-mgCELI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 20:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.12 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)) 20:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 20:49:26 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-9jtBUe-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 20:49:26 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)) 20:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 20:49:26 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-BnUb0g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 20:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.7 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)) 20:49:26 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 20:49:26 INFO - Running setup.py (path:/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/pip-iCx05C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 20:49:26 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)) 20:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:49:26 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==0.17->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 20:49:26 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)) 20:49:26 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:49:26 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.48->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 20:49:26 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 20:49:26 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 20:49:26 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 20:49:26 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 20:49:26 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 20:49:26 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 20:49:26 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 20:49:29 INFO - Downloading blessings-1.6.tar.gz 20:49:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 20:49:29 INFO - Installing collected packages: blessings 20:49:29 INFO - Running setup.py install for blessings 20:49:29 INFO - Successfully installed blessings 20:49:29 INFO - Cleaning up... 20:49:29 INFO - Return code: 0 20:49:29 INFO - Done creating virtualenv /builds/slave/test/build/venv. 20:49:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:49:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:49:29 INFO - Reading from file tmpfile_stdout 20:49:29 INFO - Current package versions: 20:49:29 INFO - blessings == 1.6 20:49:29 INFO - blobuploader == 1.2.4 20:49:29 INFO - docopt == 0.6.1 20:49:29 INFO - functools32 == 3.2.3-2 20:49:29 INFO - jsonschema == 2.5.1 20:49:29 INFO - manifestparser == 1.1 20:49:29 INFO - mozInstall == 1.12 20:49:29 INFO - mozcrash == 0.17 20:49:29 INFO - mozdebug == 0.1 20:49:29 INFO - mozdevice == 0.48 20:49:29 INFO - mozfile == 1.2 20:49:29 INFO - mozhttpd == 0.7 20:49:29 INFO - mozinfo == 0.9 20:49:29 INFO - mozleak == 0.1 20:49:29 INFO - mozlog == 3.4 20:49:29 INFO - moznetwork == 0.27 20:49:29 INFO - mozprocess == 0.23 20:49:29 INFO - mozprofile == 0.28 20:49:29 INFO - mozrunner == 6.12 20:49:29 INFO - mozscreenshot == 0.1 20:49:29 INFO - mozsystemmonitor == 0.3 20:49:29 INFO - moztest == 0.7 20:49:29 INFO - mozversion == 1.4 20:49:29 INFO - psutil == 3.1.1 20:49:29 INFO - requests == 1.2.3 20:49:29 INFO - wsgiref == 0.1.2 20:49:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 20:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:49:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 20:49:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:29 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2b34a83d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.xsRqtn23Of/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.0osfaTwA9E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:49:29 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 20:49:29 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 20:49:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xsRqtn23Of/Render', 20:49:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:49:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:49:29 INFO - 'HOME': '/Users/cltbld', 20:49:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:49:29 INFO - 'LOGNAME': 'cltbld', 20:49:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:29 INFO - 'MOZ_NO_REMOTE': '1', 20:49:29 INFO - 'NO_EM_RESTART': '1', 20:49:29 INFO - 'PAGER': '/bin/cat', 20:49:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:49:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:49:29 INFO - 'PWD': '/builds/slave/test', 20:49:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:49:29 INFO - 'SHELL': '/bin/bash', 20:49:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0osfaTwA9E/Listeners', 20:49:29 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:49:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:49:29 INFO - 'USER': 'cltbld', 20:49:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:49:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:49:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:29 INFO - 'XPC_FLAGS': '0x0', 20:49:29 INFO - 'XPC_SERVICE_NAME': '0', 20:49:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:30 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)) 20:49:30 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)) 20:49:30 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)) 20:49:30 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)) 20:49:30 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)) 20:49:30 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)) 20:49:30 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)) 20:49:30 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)) 20:49:30 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)) 20:49:30 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)) 20:49:30 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)) 20:49:30 INFO - Cleaning up... 20:49:30 INFO - Return code: 0 20:49:30 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 20:49:30 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')]} 20:49:30 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 20:49:30 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:30 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')]} 20:49:30 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 20:49:30 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 20:49:30 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 0x10a721490>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a697570>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa2b34a83d0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, '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.xsRqtn23Of/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.0osfaTwA9E/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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 20:49:30 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 20:49:30 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 20:49:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xsRqtn23Of/Render', 20:49:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:49:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:49:30 INFO - 'HOME': '/Users/cltbld', 20:49:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:49:30 INFO - 'LOGNAME': 'cltbld', 20:49:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:30 INFO - 'MOZ_NO_REMOTE': '1', 20:49:30 INFO - 'NO_EM_RESTART': '1', 20:49:30 INFO - 'PAGER': '/bin/cat', 20:49:30 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:49:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:49:30 INFO - 'PWD': '/builds/slave/test', 20:49:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:49:30 INFO - 'SHELL': '/bin/bash', 20:49:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0osfaTwA9E/Listeners', 20:49:30 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:49:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:49:30 INFO - 'USER': 'cltbld', 20:49:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:49:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:49:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:30 INFO - 'XPC_FLAGS': '0x0', 20:49:30 INFO - 'XPC_SERVICE_NAME': '0', 20:49:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:49:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 20:49:30 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 20:49:30 INFO - Cleaning up... 20:49:30 INFO - Return code: 0 20:49:30 INFO - Running post-action listener: _resource_record_post_action 20:49:30 INFO - Running post-action listener: _start_resource_monitoring 20:49:30 INFO - Starting resource monitoring. 20:49:30 INFO - [mozharness: 2017-01-03 04:49:30.347566Z] Finished create-virtualenv step (success) 20:49:30 INFO - [mozharness: 2017-01-03 04:49:30.348567Z] Running install step. 20:49:30 INFO - Running pre-action listener: _resource_record_pre_action 20:49:30 INFO - Running main action method: install 20:49:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 20:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 20:49:30 INFO - Reading from file tmpfile_stdout 20:49:30 INFO - Detecting whether we're running mozinstall >=1.0... 20:49:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 20:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 20:49:30 INFO - Reading from file tmpfile_stdout 20:49:30 INFO - Output received: 20:49:30 INFO - Usage: mozinstall [options] installer 20:49:30 INFO - Options: 20:49:30 INFO - -h, --help show this help message and exit 20:49:30 INFO - -d DEST, --destination=DEST 20:49:30 INFO - Directory to install application into. [default: 20:49:30 INFO - "/builds/slave/test"] 20:49:30 INFO - --app=APP Application being installed. [default: firefox] 20:49:30 INFO - mkdir: /builds/slave/test/build/application 20:49:30 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-51.0.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 20:49:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-51.0.en-US.mac.dmg --destination /builds/slave/test/build/application 20:49:52 INFO - Reading from file tmpfile_stdout 20:49:52 INFO - Output received: 20:49:52 INFO - /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox 20:49:52 INFO - Running post-action listener: _resource_record_post_action 20:49:52 INFO - [mozharness: 2017-01-03 04:49:52.501589Z] Finished install step (success) 20:49:52 INFO - [mozharness: 2017-01-03 04:49:52.501742Z] Running run-tests step. 20:49:52 INFO - Running pre-action listener: _resource_record_pre_action 20:49:52 INFO - Running main action method: run_tests 20:49:52 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 20:49:52 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 20:49:52 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 20:49:52 INFO - 2017-01-02 20:49:52.516 screenresolution[1630:8251] starting screenresolution argv=screenresolution get 20:49:52 INFO - 2017-01-02 20:49:52.518 screenresolution[1630:8251] Display 0: 1600x1200x32@60 20:49:52 INFO - 2017-01-02 20:49:52.524 screenresolution[1631:8254] starting screenresolution argv=screenresolution list 20:49:52 INFO - Available Modes on Display 0 20:49:52 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 20:49:52 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 20:49:52 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 20:49:52 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 20:49:52 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 20:49:52 INFO - Intel Iris: 20:49:52 INFO - Chipset Model: Intel Iris 20:49:52 INFO - Type: GPU 20:49:52 INFO - Bus: Built-In 20:49:52 INFO - VRAM (Dynamic, Max): 1536 MB 20:49:52 INFO - Vendor: Intel (0x8086) 20:49:52 INFO - Device ID: 0x0a2e 20:49:52 INFO - Revision ID: 0x0009 20:49:52 INFO - Displays: 20:49:52 INFO - Display: 20:49:52 INFO - Resolution: 1600 x 1200 @ 60 Hz 20:49:52 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 20:49:52 INFO - Display Serial Number: 1600x1200 60 20:49:52 INFO - Main Display: Yes 20:49:52 INFO - Mirror: Off 20:49:52 INFO - Online: Yes 20:49:52 INFO - Rotation: Supported 20:49:52 INFO - Return code: 0 20:49:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 20:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 20:49:52 INFO - Python 2.7.3 20:49:52 INFO - Return code: 0 20:49:52 INFO - grabbing minidump binary from tooltool 20:49:52 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')]} 20:49:52 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 0x10a535d30>, '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 0x10a39bdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a52db20>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 20:49:52 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 20:49:52 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 20:49:52 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 20:49:52 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 20:49:52 INFO - Return code: 0 20:49:52 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 20:49:52 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 20:49:52 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 20:49:52 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 20:49:52 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 20:49:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 20:49:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Beta --suite dromaeojs --executablePath /builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0112 --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 20:49:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.xsRqtn23Of/Render', 20:49:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 20:49:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 20:49:52 INFO - 'HOME': '/Users/cltbld', 20:49:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 20:49:52 INFO - 'LOGNAME': 'cltbld', 20:49:52 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 20:49:52 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 20:49:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 20:49:52 INFO - 'MOZ_NO_REMOTE': '1', 20:49:52 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 20:49:52 INFO - 'NO_EM_RESTART': '1', 20:49:52 INFO - 'PAGER': '/bin/cat', 20:49:52 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 20:49:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 20:49:52 INFO - 'PWD': '/builds/slave/test', 20:49:52 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 20:49:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 20:49:52 INFO - 'SHELL': '/bin/bash', 20:49:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.0osfaTwA9E/Listeners', 20:49:52 INFO - 'TMPDIR': '/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/', 20:49:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 20:49:52 INFO - 'USER': 'cltbld', 20:49:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 20:49:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 20:49:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 20:49:52 INFO - 'XPC_FLAGS': '0x0', 20:49:52 INFO - 'XPC_SERVICE_NAME': '0', 20:49:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 20:49:52 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Beta', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0112', '--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 20:49:53 INFO - mozversion application_buildid: 20170102193119 20:49:53 INFO - mozversion application_changeset: b40eb1f2db20c3e3052b6fb6d003870aca751934 20:49:53 INFO - mozversion application_display_name: Firefox 20:49:53 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 20:49:53 INFO - mozversion application_name: Firefox 20:49:53 INFO - mozversion application_remotingname: firefox 20:49:53 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-beta 20:49:53 INFO - mozversion application_vendor: Mozilla 20:49:53 INFO - mozversion application_version: 51.0 20:49:53 INFO - mozversion platform_buildid: 20170102193119 20:49:53 INFO - mozversion platform_changeset: b40eb1f2db20c3e3052b6fb6d003870aca751934 20:49:53 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-beta 20:49:53 INFO - mozversion platform_version: 51.0 20:49:53 INFO - using testdate: 1483418993 20:49:53 INFO - actual date: 1483418993 20:49:53 INFO - starting webserver on 'localhost:49243' 20:49:53 INFO - SUITE-START | Running 2 tests 20:49:53 INFO - TEST-START | dromaeo_css 20:49:53 INFO - operating with platform_type : mac_ 20:49:53 INFO - Initialising browser for dromaeo_css test... 20:49:53 INFO - TEST-INFO | started process 1641 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpLpu8Jl/profile http://localhost:49243/getInfo.html) 20:49:55 INFO - PROCESS | 1641 | __metrics Screen width/height:1600/1200 20:49:55 INFO - PROCESS | 1641 | colorDepth:24 20:49:55 INFO - PROCESS | 1641 | Browser inner width/height: 1024/689 20:49:55 INFO - PROCESS | 1641 | __metrics 20:49:55 INFO - PROCESS | 1641 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 20:49:55 INFO - PROCESS | 1641 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 20:49:56 INFO - TEST-INFO | 1641: exit 0 20:49:56 INFO - Browser initialized. 20:49:56 INFO - Running cycle 1/1 for dromaeo_css test... 20:49:56 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpLpu8Jl/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 20:50:08 INFO - PROCESS | 1645 | RSS: Main: 168919040 20:50:08 INFO - PROCESS | 1645 | 20:50:59 INFO - PROCESS | 1645 | 1483419059884 addons.productaddons ERROR Request failed certificate checks: [Exception... "SSL is required and URI scheme is not https." nsresult: "0x8000ffff (NS_ERROR_UNEXPECTED)" location: "JS frame :: resource://gre/modules/CertUtils.jsm :: checkCert :: line 145" data: no] 20:53:09 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 20:53:11 INFO - PROCESS | 1645 | RSS: Main: 320270336 20:53:11 INFO - PROCESS | 1645 | 20:56:14 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 20:56:14 INFO - PROCESS | 1645 | RSS: Main: 300007424 20:56:14 INFO - PROCESS | 1645 | 20:59:17 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 20:59:17 INFO - PROCESS | 1645 | RSS: Main: 279396352 20:59:17 INFO - PROCESS | 1645 | 21:02:19 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 21:02:20 INFO - PROCESS | 1645 | RSS: Main: 275947520 21:02:20 INFO - PROCESS | 1645 | 21:05:23 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 21:05:24 INFO - PROCESS | 1645 | RSS: Main: 266936320 21:05:24 INFO - PROCESS | 1645 | 21:08:26 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 21:08:27 INFO - PROCESS | 1645 | RSS: Main: 404344832 21:08:27 INFO - PROCESS | 1645 | 21:08:27 INFO - PROCESS | 1645 | __start_tp_report 21:08:27 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 21:08:27 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 21:08:27 INFO - PROCESS | 1645 | |i|pagename|runs| 21:08:27 INFO - PROCESS | 1645 | |0;dojo.html;3430.811305378205;3445.104272889049;3474.2704032153247;3496.493008513767;3510.350585141747;5694.6867922264255;5763.798267060653;5767.538596912247;5782;5786.82639520814;5727.885442291152;5770.653760774357;5793.391693872146;5806.883862322751;5808.448197421249;5212.556932660728;5255.658382205163;5275.366955965271;5316.73416329184;5318.760655770499;5219.295395121648;5221.2951251580935;5233.816816411427;5383.219433182187;5392.946070539284;4770.117528257266;4844.515548445145;5279.366476022883;5305.230741542474;5328.866778330534;5288.6562373445795;5365.892682146375;5366;5368.4363141869935;5371.301730775013;5228.189630607262;5267.736613169326;5317.229001794718;5320.308359913225;5320.946790532123;4620.468646105707;5586.497215250647;5634.802781902614;5673.659580425187;5676.631018983794;4703.6942598730975;6188.938110618881;6229;6231.563790534665;6237.7816776413065;6242.87514249717;6258.436740693314;6297.433231009185;6308.968455157741;6311.652859092748;4726.409198850144;5702.543796496312;5739.569532285095;5761.5102716269585;5860.413958604106;6253.312135665074;6253.96873015632;6272.090546870678;6279.309275979638;6287.339829317947;5152.407473140562;6205.6586887721605;6234.0337247726675;6247.843803904939;6259.968700156561;5018.774155163026;6134.44789968896;6180.412860778219;6256.499480041586;6306.653134077578;6115.358579221981;6163.9383606164265;6167.537434692326;6248;6265.71804268809;6256.968715156395;6281.2462504498835;6292.811215663537;6297.6536290503545;6305.8108256752375;4846.103470857832;5002.649814512949;5012.373453318335;5021.995600879839;5040.243963405445;4447.266201076851;4451.310046942729;4505;4513.661475389359;4527.094581083797;5930.495907847881;5930.911036334458;5940.61386009908;5946.70266486674;5949.494292985145;6276.843078922972;6278.30938596754;6296.118543403835;6300.401461861115;6307.495400368051;5643.068893632587;5735.741891614887;5757.8560535986935;5798.9420105799245;5916.881662366729;5429.701366424805;5467.6719396836315;5480.506754392124;5482.890342193214;5512.366077901012;6358.682065896686;6372.2353317601255;6378.936210637927;6395.072714456471;6398.2322121344805;6173.753049877954;6224.439800417984;6274.1843560336865;6297.275813281348;6305.306416294112;6214.4407003369915;6259.2488901332135;6260.874782504234;6264.718087686157;6335.176427064452;5212.582993360598;6194.256689197326;6195.752169913153;6236.844078898064;6252.124702541557;6213.96893015532;6270.561060725706;6273.215022699235;6278.560500765086;6294.71673774672;5961.195238642727;6067.271927368744;6093.329733729375;6097.7865774697675;6125.989211780006;6204.751809927552;6213.565050446426;6217.09852071438;6222.81331560054;6223.533235007302;5350.545203657733;6086.300075491198;6109.17526133984;6110.2973158085615;6115.3578874217565;5972.850678732892;5994.400559943971;6098.586015328515;6101.389861013863;6124.0201567748945;6006.309274433496;6051.394860513913;6061.818145455643;6062.272527296753;6096.603720758137 21:08:27 INFO - PROCESS | 1645 | |1;ext.html;472.56760064540947;497.4503173992738;528.7462018231251;538.9110796718542;547.4580165636022;32524.349513009725;33183.00450986468;33187.17032074196;33254.66745332546;34651.65348346516;44279.89300267495;45769.85575360609;45852.54147458525;47807;47980.800479988015;10013.549390277454;10178.23663225261;10192;10193.490325483734;10203.285769996104;9289.44263344198;9889.258305627107;10002.099811017008;10002.749931251741;10002.899971000306;9311.068893110669;12239.632811015685;12563.183393079466;12566.99464042879;12683.112182147208;12481.687957801038;12540.686482837911;12545.74908501834;12556.121071524996;12561.811572826415;12160.817587736192;12236.694082647917;12239.082068844784;12247.326397048158;12271.447784849703;37594.8120259397;41198.55805046809;42777.35833962493;43207.56792432067;43209.567904320866;3353.547271118392;3412.522246885438;3441.3117376524547;3535.398982173011;4199.286121359376;25102.99588016477;31522.842385788153;31591.578378973;32249.742518023748;34105;3103.7672174586996;3207;3211.1490455029434;3254.040058182818;3283.868645254187;537921;538038;538215;538412.3079384578;539326;35791.82104089463;36852.44721329182;62001.759964800454;62116.37883621197;62242.13273601799;38056.42915356272;38240.85277441681;38264.80867595644;38325.61674383276;38347.2330553393;15889.920550397173;16047.117408542408;16050.75923861143;16071.598210044609;16078.678426431406;13358.532451364155;13418.798718019238;13428;13447.596572102853;13488;7739;7900.170482099296;8164.6325915333955;8263.173682631688;8348.833023339499;3359.5128706337446;3409.335179639996;3413.4026545354463;3444.793312401264;3445.1214940190093;913.0777914306466;926.6895589977433;947.7111128864739;973.8587904753771;986.8075725233654;31123.377532449224;31989.68010319867;32065.679343206735;32110.678893211236;32646.183845404055;976.8778902637171;1004.6282875336173;1018.9861088217123;1139.0602752728867;1172.8592568891788;13512.459501620022;16498.845080844225;16698.916505417394;16785.32858685639;17079.743803842954;196178;205151.97424013083;205207.97396012925;205407;205681;54328.72835635796;55480;62301.06548401687;62808.68595656993;63292.36707632957;1404.262762049932;1411.985880141206;1453.9854601454063;1454.8254209494928;1457.992710036443;27529.311767205178;31183;32728.67271327256;33570.66429335676;34275.82862085674;56023.719881400335;56624.15063774129;56658.150127748944;56695.58261043507;56708.582285441546;591146;594484;596487;596951;598129;28641.28396790097;28913.7108628911;29190.854045729637;29309.827606895484;29332.266693332836;49649;49825.25262121144;50054;50412.747936260086;51343.71640708863;41156.79421602873;42317.345369773815;42696.7190984271;42773.786131069144;42833.78583107064;41354.586454136275;41413.58586414097;42759.717208483795;43563.34654980114;44581.10837783291;41175.7941210304;41276.793616031726;41741.79129104335;42138.15723685448;42148.73553793391;34543;35989.82005089958;36933;37093.62906370902;37299;27152.456950860476;27287.454250915267;27318.726812731617;27343.86328068347;27402.725972740816 21:08:27 INFO - PROCESS | 1645 | |2;jquery.html;381.854895139847;386.63380113704136;387.16565800699493;393.84049459968713;413.1633442279384;19980.200791968324;21380.786192138075;21407.67888481674;21595.46011349717;22080;20691.101986993133;20709;21184.57630847382;21338.46653833655;21614.3515694529;4981.25281207819;6183.319834818189;6211.130441738161;6243.90634140486;6249.125122482856;5421.864453388677;5713;6101.176341193948;6185.381461853801;6196.225471816023;6074;6087.421694938974;6088.36072212418;6097.085437184413;6101.237345331833;5802.941970580304;6012.428819262207;6056.818295451121;6070.271567411917;6085.600311928281;5307.9734601326745;5310.336207974004;5314.681119132864;5316.40507847648;5317.175837745156;25323.366915827068;25336;25425.618615720778;25774.48451030969;26041.73958260431;2362.598358279097;2390.5457962986975;2482.838615489987;2530.708968468631;3140.3876244132402;15247;15497.690046199014;15568.299426525833;16367.754483682755;16407.507774766775;1755.9385421510315;1908.9119202054835;1937.2638397409034;1943.9028048597654;1946.4452631000097;76141.85787213141;116742.83257167405;121094.39452802768;125972.37013814872;127451;9462.952685236529;10400.27198096126;10739.83890241647;10776.29954052984;10816.459177041117;13945.860541394457;13948;13951.790723139162;13956.790648140286;13963.79054314186;8555.443896146731;8761.605727742139;8769.298456123623;8856.335774816915;8893.28853691703;7410.407167426593;8893.4663920165;8918.643254269757;8926.946802235521;9079.863802042975;6475.579087359307;6599.91101468262;6607.9669601651685;6609.074729537869;6613.710326486289;1818.6362727454562;1836.0819590204896;1843.889366638006;1845.2987864611362;1848.6672398968315;865.6191275838611;923.9491827949392;952.9422341201262;994.3536701144315;1025.5026312238558;22094.447638809157;22654.886725566266;22880.885595571915;22908.198213062464;23040.769592304197;952.4856577448239;963.5519483440233;980.4313498171043;995.6266400099962;1046.1108058150512;11107.944460277648;11840.407979600985;11911.642650720492;11950.223235489839;12019.63941081769;588650;614861;620145;622749;633358;86952.56523717467;87576.12423875679;93010.60484092744;94022.5298873515;126017;1004.718678769931;1068.834330678746;1115.286216821235;1116.2967330581682;1119.9160062995309;20296.492587685425;20445.89777051165;21025.789742102384;21053;21069;37141.62858371382;47303;53048.4695153059;55041.72479137579;55385.72307138438;69461.30538694751;84246;85952;85955;86920.1307986912;7929.127795942326;8103;8200.58997050157;8216.56210163231;8260.917390826255;11890.702732431759;12561.623151305475;12644;12726.68183295425;13067.934660327019;5358.892822143457;5845.590808643354;9541.568764685353;11208.831867522156;11467.483963221843;9780.462074585967;10726.356418614909;10928.486448116819;10995.945020274847;11012.39431831257;11232.83150752723;11255.718607034889;11333.206675532634;11503.964643182153;11582.594609188638;7903.644336004779;8085.151059138706;8105.392095592736;8212.384071194565;8244.711435099744;8202.09776924526;10507.00183482568;10908.236423450282;11330.320180789178;11543.249688770204 21:08:27 INFO - PROCESS | 1645 | |3;mootools.html;1381.6545863534116;1521.0873475914452;1735.6615459985308;1922.7596550431197;1954.9315773947915;8612.483251004944;9154.404963677365;9161.587728552215;9177.724668259954;9203.953980230106;6845.315468453152;6908.412784913288;7087.53930994485;8411.453255538401;8625.87061194081;2387.2957477544123;2411.6503107049466;2419.5765740995344;2419.758024197584;2420.177139772477;2373.371056669984;2378.4648454097864;2415.2150551070886;2415.698037745282;2424.103081859714;2407.0732767884315;2413.7706917842775;2425.151197081025;2428.441458464554;2433.561958847407;2386.880655967195;2395.4610212702178;2403.495265994152;2406.4585468269674;2412.179858848;2384.0106355862295;2395.173665085543;2399.940001499959;2404.5912194926905;2407.4462873539183;8740.956295218482;8829.249513791336;8842.734717958472;8986.68546600866;9137.908620913839;5384.623076384654;5540.584456165804;5557.194206840026;5559.749811258503;5565.833025009256;3524.823758812049;3642.289753498069;3689.4465830125428;3695.4456831475495;3730.925381492355;1098.3849044535007;1098.8846171151995;1100.5927806711488;1115.4311301236428;1125.8142406502918;11933.761324773543;11960.880391196064;12014.459349329214;12044.21712588679;12061.698457538543;3960.821763020671;4496.527864574238;4541.091781643619;4731.432228132578;4731.645126615517;9275.443473391619;9279.489628070385;9282.814343713088;9308.255339572817;9309.813803723888;5316.388615309212;5323.760430780624;5329.866753331198;5339.279197308391;5341.412444631087;4550.249208880564;4704.811807527661;4902.289168070681;4984.177610694267;4994.350734404504;3853.653171214548;3872.5740168581433;3951.8024098794945;3962.9009274767786;3983.2630963271886;1153.4578747988432;1164.441068287227;1164.5109054197258;1184.768970050849;1185.4487663236637;782.9765107046798;863.9955303695492;889.7375274294099;910.7814124610178;913.9946059334811;5807.361190269067;5829.970850145807;5836.533077353802;6114.419130182714;6162.291336496271;896.8385940207447;913.584319134792;929.2612373163216;947.7630592351912;1003.5885287032428;3494.2836718472654;3908.7459315144993;3946.427767973628;3960.663343615767;4095.0990782027907;10622;11096.167787415976;11100.333979961228;11104.000639942444;11142.554297828157;11020.173486988508;11044.33733975964;11044.834327485094;11046.281991670516;11092.556297748;8023.1575684553445;8264.132266112092;8388.783626374263;8394.412391132562;8517.276031537265;5969.3345903836;5973.701314934149;6040.244969378828;6173.444390004921;6173.783917562864;10141.645042423479;10312.432816195182;10398.844017339898;10420.739481513023;10437.373757574569;10286.382817031003;10346.793064138825;10463.162946964378;10469.633562825264;10490.213234007328;7093.964530177316;7300.926990730025;7304.890426643711;7763.68945242184;7856.37149028065;7869.527828330319;8078.87881681787;8428.747137585882;8570.785730356542;8725.127487251224;7604.505707129019;7758.8448231033935;7762.728304509315;7809.492382995087;7849.1758365370815;7517.624118794148;7602.695892164252;7642.541447513167;7684;7817.609119544114;6189.257289125334;7129.322714342129;7213.134423868959;7240.384567311627;7245.963770181115;4891.315215869852;4936.770670360488;4987.326710893983;5049.444561098349;5103.540681338697;5052.5705315048635;5068.113080210875;5202;5221.112410890082;5252.054630166606 21:08:27 INFO - PROCESS | 1645 | |4;prototype.html;270.02520899552616;312.97809153359276;316.0502689418297;322.89505910579066;326.9836508174591;4554.931676024854;4668.346431499588;5382.757775900084;5527.861803454915;5602.271704678396;4236.682248831335;4354.499232588253;4459.353393757903;4471.5629981659995;5451.672899626015;3367.478040903664;3876.6704830089475;3997.5802540733166;4193.630598711733;4256.59562341577;4222.472190976128;4256.254935476455;4263.2965560682605;4268.935965960498;4287.742735435868;4051.837926482952;4186;4222.028933345332;4235.280002399584;4240.512341080785;4202.516710578277;4204.222218889515;4206.242876282268;4207.663386929038;4239.622122810084;3674.5590529136407;3682.6869716073898;3699.5375578052744;3704.1850792825535;3705.907352316187;4584.6561507887045;5029.547340739315;5345.636862600051;5385.5960802939935;5385.623006389555;4817.566419022305;4817.7591120444185;4821;4822.638302127354;4845.442774080955;4820.421549414058;5660.433956604348;5706.715988902505;5727.914081288784;5778.8266352009505;3716.888493345204;3893.3965235388278;4061.208064427438;4092.7544347339253;4097.098638299599;5435.374931882845;5761.436160908397;5957.09810074402;6051.394860513913;6056.424639659225;3509.5437593113243;4149.647279981235;4158.629581138722;4160.167966406731;4164.917541229324;3995.9400608990886;4234.301340278819;4234.87295381139;4261.680373971964;4271.444712187395;3689.9077523062138;4217.325227963511;4317.956820431818;4652.395188625457;4849.684770489906;5775.653460792366;5795.478406943311;5809.622374545641;5842.8539286517325;5843.678597677083;1266.8479782426168;1338.6519504928594;1421.374595178139;1451.8548145185607;1462.4515806572535;696.8989496522976;801.3052394186254;868.9478631282017;892.7991850960448;897.5736525150501;4614.131276832888;4649.744264065509;4652.767361631905;4669.34629151919;4744.952550474451;4953.975230123826;4974.90050198994;4981.975090124599;5008.749562521859;5040.899182016339;4311.9784401077795;4369.269206745784;4474.172278128557;4634.073185362941;4694.2723877799;2226.4062367341867;2361.397843549884;2417.3231495181376;2601.91846522781;2612.1902210314865;4347.782630858285;4574.656900732459;4619.40630482483;4909.3126962225315;4950.034743225108;4807.759612019385;5023.79904803811;5036.722980236049;5454.372747134051;6188.938110618837;5121.564667003347;6149.864862839489;6177.6911154443;6188.783392581238;6199.5660303779205;4848.490908454562;5497.945020549743;5797.79707710245;5969;6051.727672254671;5126.4617215191865;5440.238366628596;5576.800987787645;5704.258446402107;5893.261487861006;5622.971885140548;5882.205902203319;6185.226846644169;6194.5973511721595;6208.379162083756;3848.4034974578985;4003.11931375097;4019.4774679291504;4019.577944315805;4033.91932161361;5575.386707462095;5939.524838013035;5971.790987315423;5980.302061690934;6008;4873.853784386474;5388.784448622011;5625.831225063254;5838.32859221178;5939.346671866005;4906.313116163668;5310.787568497217;5578.884223155466;5825.378579639264;5846.503047241032;4665.4634717007975;4956.727379994135;5694.544436445157;5702.8289151325525;5707.229524014371;5653.378128405954;5859.560532959959;5868.911966320594;5871.559633027455;5890.6760128191645;4819.927701084416;5754.4533269339345;5765.8558536036935;5766.895083294651;5826.621269617631 21:08:27 INFO - PROCESS | 1645 | |5;yui.html;714.3142583120205;755.7203834581204;803.4295650088437;817.3461231015186;845.602566793607;16012.599685007866;17250.137493125356;17314.56713582161;17323.82676173236;17346.826531734696;14582.416703331854;14634.926825365857;14640.780388294157;14652.853471465281;14655.633609159777;703.2159142556064;723.6671131279618;725.3182008911632;730.7844185965153;862.7109918177418;727.3526561360394;729.6716477585081;869.8738682891009;895.3240303570794;900.4372267332917;937.6999360204737;945.9763505912339;950.4629884115452;953.4136506048765;955.1451450951395;946.9337146399789;948.7628092976756;949.5157469690439;950.1923365139645;950.4629884115452;706.6502081469705;711.3668834737089;712.6971037309123;712.7683502861539;717.0105254748466;15691.843081569266;15868;15912.283947222402;15916.840831591768;15926.840731592767;13422.798658020138;13568.253746043963;13581.660458488517;13999.790003149961;14041.368138433794;13130.671733206651;13316.467341306434;13506.257155856423;13648.522301719393;13687.726245475034;4656.837010704609;4716.764161791897;4746.121967436035;4757.405324334458;4882.36529251195;120466;121991.39004304922;126115;130332;133172.33413832868;11040.613578524713;11225.270357426905;11330.433478326051;11418.371989540488;11758.706032349088;21942;21994.670079948814;22129.55740885173;22132.557348852934;22313.888430557745;8060.435769496079;8098.230668086522;8148.22591853773;8159.510429374256;8261.215184557457;4491.618212451913;4534.818607255673;4704.458987216445;4736;4853.684510506806;3615.295017471568;3743.9812800936365;3772.2832661794173;3774.433834924728;3779.4897688812207;670.4301343857682;678.4470656415006;684.6029303004345;690.1200968764765;690.5649440852231;571.8884817460638;595.6574969392617;645.7158850105939;704.9777822157789;710.2400431538308;8697.478151310941;9914.900850991398;10053.346532475365;10084.69745907624;10212.846807297896;652.438902543812;672.4754691340762;692.4183685704032;699.8320403103219;712.8217945513621;4397.956020439755;4713.929291060636;4738.222892615835;4907.190313598217;5138.396871848117;140458.2977085108;158096.20951895165;161566;162739;165815;136801.31599341938;141896;142599;143877.5612243885;146538.26730866276;89056.9999999987;111086.88913110927;124135;124144;125936;10362.430066346424;10375.740606484898;10650.8402373966;10687.946560267148;10697.732556686145;66758.66620666865;67475.66262168658;67824.6608766953;70639;70656;99612;101106.98893010976;104934;105250;112138.87861121284;13201.801972970221;13596.98022648325;13707.657308567366;13781.448742050206;13965.720685586028;14895.627609309853;15026.924865375604;15111.244437777847;15512.84487155114;15970.68058638844;14024.579262622137;14063.226522541358;14373.7843932339;14473.782893256399;14477.638059048608;14013.229272390117;14653.340599673253;14877.553673389815;15024.17367044823;15052.473163439226;14124;14207.218602976522;14378.065425747292;14739.041962272418;15223.391064357302;11391.177411614102;11726.296422214353;11869.169158158846;11976.401179941142;12132.757344852876;11808.586699465477;11854.762904742029;12082.516699331929;12125.211861228992;12182.269063855843 21:08:27 INFO - PROCESS | 1645 | __end_tp_report 21:08:27 INFO - PROCESS | 1645 | __start_cc_report 21:08:27 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1422 21:08:27 INFO - PROCESS | 1645 | __end_cc_report 21:08:27 INFO - PROCESS | 1645 | __startTimestamp1483420107090__endTimestamp 21:08:27 INFO - PROCESS | 1645 | 21:08:27 INFO - PROCESS | 1645 | ------- Summary: start ------- 21:08:27 INFO - PROCESS | 1645 | Number of tests: 6 21:08:27 INFO - PROCESS | 1645 | 21:08:27 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5750.40 Median:5994.40 stddev:644.52 (10.8%) stddev-sans-first:620.27 21:08:27 INFO - PROCESS | 1645 | Values: 3430.8 3445.1 3474.3 3496.5 3510.4 5694.7 5763.8 5767.5 5782.0 5786.8 5727.9 5770.7 5793.4 5806.9 5808.4 5212.6 5255.7 5275.4 5316.7 5318.8 5219.3 5221.3 5233.8 5383.2 5392.9 4770.1 4844.5 5279.4 5305.2 5328.9 5288.7 5365.9 5366.0 5368.4 5371.3 5228.2 5267.7 5317.2 5320.3 5320.9 4620.5 5586.5 5634.8 5673.7 5676.6 4703.7 6188.9 6229.0 6231.6 6237.8 6242.9 6258.4 6297.4 6309.0 6311.7 4726.4 5702.5 5739.6 5761.5 5860.4 6253.3 6254.0 6272.1 6279.3 6287.3 5152.4 6205.7 6234.0 6247.8 6260.0 5018.8 6134.4 6180.4 6256.5 6306.7 6115.4 6163.9 6167.5 6248.0 6265.7 6257.0 6281.2 6292.8 6297.7 6305.8 4846.1 5002.6 5012.4 5022.0 5040.2 4447.3 4451.3 4505.0 4513.7 4527.1 5930.5 5930.9 5940.6 5946.7 5949.5 6276.8 6278.3 6296.1 6300.4 6307.5 5643.1 5735.7 5757.9 5798.9 5916.9 5429.7 5467.7 5480.5 5482.9 5512.4 6358.7 6372.2 6378.9 6395.1 6398.2 6173.8 6224.4 6274.2 6297.3 6305.3 6214.4 6259.2 6260.9 6264.7 6335.2 5212.6 6194.3 6195.8 6236.8 6252.1 6214.0 6270.6 6273.2 6278.6 6294.7 5961.2 6067.3 6093.3 6097.8 6126.0 6204.8 6213.6 6217.1 6222.8 6223.5 5350.5 6086.3 6109.2 6110.3 6115.4 5972.9 5994.4 6098.6 6101.4 6124.0 6006.3 6051.4 6061.8 6062.3 6096.6 21:08:27 INFO - PROCESS | 1645 | 21:08:27 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:59830.46 Median:3443.05 stddev:128192.64 (3723.2%) stddev-sans-first:128474.79 21:08:27 INFO - PROCESS | 1645 | Values: 472.6 497.5 528.7 538.9 547.5 32524.3 33183.0 33187.2 33254.7 34651.7 44279.9 45769.9 45852.5 47807.0 47980.8 10013.5 10178.2 10192.0 10193.5 10203.3 9289.4 9889.3 10002.1 10002.7 10002.9 9311.1 12239.6 12563.2 12567.0 12683.1 12481.7 12540.7 12545.7 12556.1 12561.8 12160.8 12236.7 12239.1 12247.3 12271.4 37594.8 41198.6 42777.4 43207.6 43209.6 3353.5 3412.5 3441.3 3535.4 4199.3 25103.0 31522.8 31591.6 32249.7 34105.0 3103.8 3207.0 3211.1 3254.0 3283.9 537921.0 538038.0 538215.0 538412.3 539326.0 35791.8 36852.4 62001.8 62116.4 62242.1 38056.4 38240.9 38264.8 38325.6 38347.2 15889.9 16047.1 16050.8 16071.6 16078.7 13358.5 13418.8 13428.0 13447.6 13488.0 7739.0 7900.2 8164.6 8263.2 8348.8 3359.5 3409.3 3413.4 3444.8 3445.1 913.1 926.7 947.7 973.9 986.8 31123.4 31989.7 32065.7 32110.7 32646.2 976.9 1004.6 1019.0 1139.1 1172.9 13512.5 16498.8 16698.9 16785.3 17079.7 196178.0 205152.0 205208.0 205407.0 205681.0 54328.7 55480.0 62301.1 62808.7 63292.4 1404.3 1412.0 1454.0 1454.8 1458.0 27529.3 31183.0 32728.7 33570.7 34275.8 56023.7 56624.2 56658.2 56695.6 56708.6 591146.0 594484.0 596487.0 596951.0 598129.0 28641.3 28913.7 29190.9 29309.8 29332.3 49649.0 49825.3 50054.0 50412.7 51343.7 41156.8 42317.3 42696.7 42773.8 42833.8 41354.6 41413.6 42759.7 43563.3 44581.1 41175.8 41276.8 41741.8 42138.2 42148.7 34543.0 35989.8 36933.0 37093.6 37299.0 27152.5 27287.5 27318.7 27343.9 27402.7 21:08:27 INFO - PROCESS | 1645 | 21:08:27 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:34877.95 Median:20141.01 stddev:101998.53 (506.4%) stddev-sans-first:102251.77 21:08:27 INFO - PROCESS | 1645 | Values: 381.9 386.6 387.2 393.8 413.2 19980.2 21380.8 21407.7 21595.5 22080.0 20691.1 20709.0 21184.6 21338.5 21614.4 4981.3 6183.3 6211.1 6243.9 6249.1 5421.9 5713.0 6101.2 6185.4 6196.2 6074.0 6087.4 6088.4 6097.1 6101.2 5802.9 6012.4 6056.8 6070.3 6085.6 5308.0 5310.3 5314.7 5316.4 5317.2 25323.4 25336.0 25425.6 25774.5 26041.7 2362.6 2390.5 2482.8 2530.7 3140.4 15247.0 15497.7 15568.3 16367.8 16407.5 1755.9 1908.9 1937.3 1943.9 1946.4 76141.9 116742.8 121094.4 125972.4 127451.0 9463.0 10400.3 10739.8 10776.3 10816.5 13945.9 13948.0 13951.8 13956.8 13963.8 8555.4 8761.6 8769.3 8856.3 8893.3 7410.4 8893.5 8918.6 8926.9 9079.9 6475.6 6599.9 6608.0 6609.1 6613.7 1818.6 1836.1 1843.9 1845.3 1848.7 865.6 923.9 952.9 994.4 1025.5 22094.4 22654.9 22880.9 22908.2 23040.8 952.5 963.6 980.4 995.6 1046.1 11107.9 11840.4 11911.6 11950.2 12019.6 588650.0 614861.0 620145.0 622749.0 633358.0 86952.6 87576.1 93010.6 94022.5 126017.0 1004.7 1068.8 1115.3 1116.3 1119.9 20296.5 20445.9 21025.8 21053.0 21069.0 37141.6 47303.0 53048.5 55041.7 55385.7 69461.3 84246.0 85952.0 85955.0 86920.1 7929.1 8103.0 8200.6 8216.6 8260.9 11890.7 12561.6 12644.0 12726.7 13067.9 5358.9 5845.6 9541.6 11208.8 11467.5 9780.5 10726.4 10928.5 10995.9 11012.4 11232.8 11255.7 11333.2 11504.0 11582.6 7903.6 8085.2 8105.4 8212.4 8244.7 8202.1 10507.0 10908.2 11330.3 11543.2 21:08:27 INFO - PROCESS | 1645 | 21:08:27 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5772.60 Median:4960.47 stddev:3249.33 (65.5%) stddev-sans-first:3241.69 21:08:27 INFO - PROCESS | 1645 | Values: 1381.7 1521.1 1735.7 1922.8 1954.9 8612.5 9154.4 9161.6 9177.7 9204.0 6845.3 6908.4 7087.5 8411.5 8625.9 2387.3 2411.7 2419.6 2419.8 2420.2 2373.4 2378.5 2415.2 2415.7 2424.1 2407.1 2413.8 2425.2 2428.4 2433.6 2386.9 2395.5 2403.5 2406.5 2412.2 2384.0 2395.2 2399.9 2404.6 2407.4 8741.0 8829.2 8842.7 8986.7 9137.9 5384.6 5540.6 5557.2 5559.7 5565.8 3524.8 3642.3 3689.4 3695.4 3730.9 1098.4 1098.9 1100.6 1115.4 1125.8 11933.8 11960.9 12014.5 12044.2 12061.7 3960.8 4496.5 4541.1 4731.4 4731.6 9275.4 9279.5 9282.8 9308.3 9309.8 5316.4 5323.8 5329.9 5339.3 5341.4 4550.2 4704.8 4902.3 4984.2 4994.4 3853.7 3872.6 3951.8 3962.9 3983.3 1153.5 1164.4 1164.5 1184.8 1185.4 783.0 864.0 889.7 910.8 914.0 5807.4 5830.0 5836.5 6114.4 6162.3 896.8 913.6 929.3 947.8 1003.6 3494.3 3908.7 3946.4 3960.7 4095.1 10622.0 11096.2 11100.3 11104.0 11142.6 11020.2 11044.3 11044.8 11046.3 11092.6 8023.2 8264.1 8388.8 8394.4 8517.3 5969.3 5973.7 6040.2 6173.4 6173.8 10141.6 10312.4 10398.8 10420.7 10437.4 10286.4 10346.8 10463.2 10469.6 10490.2 7094.0 7300.9 7304.9 7763.7 7856.4 7869.5 8078.9 8428.7 8570.8 8725.1 7604.5 7758.8 7762.7 7809.5 7849.2 7517.6 7602.7 7642.5 7684.0 7817.6 6189.3 7129.3 7213.1 7240.4 7246.0 4891.3 4936.8 4987.3 5049.4 5103.5 5052.6 5068.1 5202.0 5221.1 5252.1 21:08:27 INFO - PROCESS | 1645 | 21:08:27 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4547.23 Median:4821.82 stddev:1403.24 (29.1%) stddev-sans-first:1369.96 21:08:27 INFO - PROCESS | 1645 | Values: 270.0 313.0 316.1 322.9 327.0 4554.9 4668.3 5382.8 5527.9 5602.3 4236.7 4354.5 4459.4 4471.6 5451.7 3367.5 3876.7 3997.6 4193.6 4256.6 4222.5 4256.3 4263.3 4268.9 4287.7 4051.8 4186.0 4222.0 4235.3 4240.5 4202.5 4204.2 4206.2 4207.7 4239.6 3674.6 3682.7 3699.5 3704.2 3705.9 4584.7 5029.5 5345.6 5385.6 5385.6 4817.6 4817.8 4821.0 4822.6 4845.4 4820.4 5660.4 5706.7 5727.9 5778.8 3716.9 3893.4 4061.2 4092.8 4097.1 5435.4 5761.4 5957.1 6051.4 6056.4 3509.5 4149.6 4158.6 4160.2 4164.9 3995.9 4234.3 4234.9 4261.7 4271.4 3689.9 4217.3 4318.0 4652.4 4849.7 5775.7 5795.5 5809.6 5842.9 5843.7 1266.8 1338.7 1421.4 1451.9 1462.5 696.9 801.3 868.9 892.8 897.6 4614.1 4649.7 4652.8 4669.3 4745.0 4954.0 4974.9 4982.0 5008.7 5040.9 4312.0 4369.3 4474.2 4634.1 4694.3 2226.4 2361.4 2417.3 2601.9 2612.2 4347.8 4574.7 4619.4 4909.3 4950.0 4807.8 5023.8 5036.7 5454.4 6188.9 5121.6 6149.9 6177.7 6188.8 6199.6 4848.5 5497.9 5797.8 5969.0 6051.7 5126.5 5440.2 5576.8 5704.3 5893.3 5623.0 5882.2 6185.2 6194.6 6208.4 3848.4 4003.1 4019.5 4019.6 4033.9 5575.4 5939.5 5971.8 5980.3 6008.0 4873.9 5388.8 5625.8 5838.3 5939.3 4906.3 5310.8 5578.9 5825.4 5846.5 4665.5 4956.7 5694.5 5702.8 5707.2 5653.4 5859.6 5868.9 5871.6 5890.7 4819.9 5754.5 5765.9 5766.9 5826.6 21:08:27 INFO - PROCESS | 1645 | 21:08:27 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:27015.65 Median:164277.00 stddev:43413.90 (26.4%) stddev-sans-first:43490.77 21:08:27 INFO - PROCESS | 1645 | Values: 714.3 755.7 803.4 817.3 845.6 16012.6 17250.1 17314.6 17323.8 17346.8 14582.4 14634.9 14640.8 14652.9 14655.6 703.2 723.7 725.3 730.8 862.7 727.4 729.7 869.9 895.3 900.4 937.7 946.0 950.5 953.4 955.1 946.9 948.8 949.5 950.2 950.5 706.7 711.4 712.7 712.8 717.0 15691.8 15868.0 15912.3 15916.8 15926.8 13422.8 13568.3 13581.7 13999.8 14041.4 13130.7 13316.5 13506.3 13648.5 13687.7 4656.8 4716.8 4746.1 4757.4 4882.4 120466.0 121991.4 126115.0 130332.0 133172.3 11040.6 11225.3 11330.4 11418.4 11758.7 21942.0 21994.7 22129.6 22132.6 22313.9 8060.4 8098.2 8148.2 8159.5 8261.2 4491.6 4534.8 4704.5 4736.0 4853.7 3615.3 3744.0 3772.3 3774.4 3779.5 670.4 678.4 684.6 690.1 690.6 571.9 595.7 645.7 705.0 710.2 8697.5 9914.9 10053.3 10084.7 10212.8 652.4 672.5 692.4 699.8 712.8 4398.0 4713.9 4738.2 4907.2 5138.4 140458.3 158096.2 161566.0 162739.0 165815.0 136801.3 141896.0 142599.0 143877.6 146538.3 89057.0 111086.9 124135.0 124144.0 125936.0 10362.4 10375.7 10650.8 10687.9 10697.7 66758.7 67475.7 67824.7 70639.0 70656.0 99612.0 101107.0 104934.0 105250.0 112138.9 13201.8 13597.0 13707.7 13781.4 13965.7 14895.6 15026.9 15111.2 15512.8 15970.7 14024.6 14063.2 14373.8 14473.8 14477.6 14013.2 14653.3 14877.6 15024.2 15052.5 14124.0 14207.2 14378.1 14739.0 15223.4 11391.2 11726.3 11869.2 11976.4 12132.8 11808.6 11854.8 12082.5 12125.2 12182.3 21:08:27 INFO - PROCESS | 1645 | -------- Summary: end -------- 21:08:27 INFO - PROCESS | 1645 | 21:08:27 INFO - TEST-INFO | 1645: exit 0 21:08:27 INFO - TEST-OK | dromaeo_css | took 1114619ms 21:08:27 INFO - TEST-START | kraken 21:08:27 INFO - operating with platform_type : mac_ 21:08:27 INFO - Initialising browser for kraken test... 21:08:27 INFO - TEST-INFO | started process 1652 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpwewldr/profile http://localhost:49243/getInfo.html) 21:08:29 INFO - PROCESS | 1652 | __metrics Screen width/height:1600/1200 21:08:29 INFO - PROCESS | 1652 | colorDepth:24 21:08:29 INFO - PROCESS | 1652 | Browser inner width/height: 1024/689 21:08:29 INFO - PROCESS | 1652 | __metrics 21:08:29 INFO - PROCESS | 1652 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 693: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 21:08:29 INFO - PROCESS | 1652 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 211: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 21:08:30 INFO - TEST-INFO | 1652: exit 0 21:08:30 INFO - Browser initialized. 21:08:30 INFO - Running cycle 1/1 for kraken test... 21:08:30 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Firefox.app/Contents/MacOS/firefox -foreground -profile /var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/T/tmpwewldr/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 21:08:42 INFO - PROCESS | 1654 | RSS: Main: 168599552 21:08:42 INFO - PROCESS | 1654 | 21:08:45 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 21:08:45 INFO - PROCESS | 1654 | RSS: Main: 218615808 21:08:45 INFO - PROCESS | 1654 | 21:08:48 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 21:08:49 INFO - PROCESS | 1654 | RSS: Main: 233349120 21:08:49 INFO - PROCESS | 1654 | 21:08:52 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 21:08:52 INFO - PROCESS | 1654 | RSS: Main: 329097216 21:08:52 INFO - PROCESS | 1654 | 21:08:54 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 21:08:55 INFO - PROCESS | 1654 | RSS: Main: 228298752 21:08:55 INFO - PROCESS | 1654 | 21:08:57 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 21:08:58 INFO - PROCESS | 1654 | RSS: Main: 229007360 21:08:58 INFO - PROCESS | 1654 | 21:09:00 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 21:09:01 INFO - PROCESS | 1654 | RSS: Main: 268734464 21:09:01 INFO - PROCESS | 1654 | 21:09:04 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 21:09:04 INFO - PROCESS | 1654 | RSS: Main: 269336576 21:09:04 INFO - PROCESS | 1654 | 21:09:07 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 21:09:08 INFO - PROCESS | 1654 | RSS: Main: 268533760 21:09:08 INFO - PROCESS | 1654 | 21:09:09 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 21:09:10 INFO - PROCESS | 1654 | RSS: Main: 240123904 21:09:10 INFO - PROCESS | 1654 | 21:09:12 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 21:09:13 INFO - PROCESS | 1654 | RSS: Main: 245354496 21:09:13 INFO - PROCESS | 1654 | 21:09:15 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 21:09:15 INFO - PROCESS | 1654 | RSS: Main: 253898752 21:09:15 INFO - PROCESS | 1654 | 21:09:18 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 21:09:19 INFO - PROCESS | 1654 | RSS: Main: 265601024 21:09:19 INFO - PROCESS | 1654 | 21:09:22 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 21:09:22 INFO - PROCESS | 1654 | RSS: Main: 259653632 21:09:22 INFO - PROCESS | 1654 | 21:09:24 INFO - PROCESS | 1654 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 21:09:24 INFO - PROCESS | 1654 | RSS: Main: 303308800 21:09:24 INFO - PROCESS | 1654 | 21:09:24 INFO - PROCESS | 1654 | __start_tp_report 21:09:24 INFO - PROCESS | 1654 | _x_x_mozilla_page_load 21:09:24 INFO - PROCESS | 1654 | _x_x_mozilla_page_load_details 21:09:24 INFO - PROCESS | 1654 | |i|pagename|runs| 21:09:24 INFO - PROCESS | 1654 | |0;ai-astar;114;115;114;115;113;113;114;114;114;114 21:09:24 INFO - PROCESS | 1654 | |1;audio-beat-detection;143;109;109;146;107;110;109;108;137;107 21:09:24 INFO - PROCESS | 1654 | |2;audio-dft;182;182;195;259;202;183;183;181;181;184 21:09:24 INFO - PROCESS | 1654 | |3;audio-fft;81;60;73;112;63;59;58;59;83;57 21:09:24 INFO - PROCESS | 1654 | |4;audio-oscillator;87;86;128;100;97;69;91;67;68;89 21:09:24 INFO - PROCESS | 1654 | |5;imaging-gaussian-blur;86;86;87;84;88;85;89;85;88;84 21:09:24 INFO - PROCESS | 1654 | |6;imaging-darkroom;93;94;92;92;93;94;93;92;93;92 21:09:24 INFO - PROCESS | 1654 | |7;imaging-desaturate;87;85;85;85;83;85;87;82;84;84 21:09:24 INFO - PROCESS | 1654 | |8;json-parse-financial;57;51;54;73;87;47;52;78;78;89 21:09:24 INFO - PROCESS | 1654 | |9;json-stringify-tinderbox;63;72;77;73;71;68;66;67;68;68 21:09:24 INFO - PROCESS | 1654 | |10;stanford-crypto-aes;84;81;84;82;81;77;83;85;89;82 21:09:24 INFO - PROCESS | 1654 | |11;stanford-crypto-ccm;146;166;136;133;132;134;156;154;175;138 21:09:24 INFO - PROCESS | 1654 | |12;stanford-crypto-pbkdf2;205;164;163;162;163;160;160;159;161;162 21:09:24 INFO - PROCESS | 1654 | |13;stanford-crypto-sha256-iterative;66;66;66;64;66;68;65;66;65;65 21:09:24 INFO - PROCESS | 1654 | __end_tp_report 21:09:24 INFO - PROCESS | 1654 | __start_cc_report 21:09:24 INFO - PROCESS | 1654 | _x_x_mozilla_cycle_collect,1850 21:09:24 INFO - PROCESS | 1654 | __end_cc_report 21:09:24 INFO - PROCESS | 1654 | __startTimestamp1483420164686__endTimestamp 21:09:24 INFO - PROCESS | 1654 | 21:09:24 INFO - PROCESS | 1654 | ------- Summary: start ------- 21:09:24 INFO - PROCESS | 1654 | Number of tests: 14 21:09:24 INFO - PROCESS | 1654 | 21:09:24 INFO - PROCESS | 1654 | [#0] ai-astar Cycles:10 Average:114.00 Median:114.00 stddev:0.67 (0.6%) stddev-sans-first:0.71 21:09:24 INFO - PROCESS | 1654 | Values: 114.0 115.0 114.0 115.0 113.0 113.0 114.0 114.0 114.0 114.0 21:09:24 INFO - PROCESS | 1654 | 21:09:24 INFO - PROCESS | 1654 | [#1] audio-beat-detection Cycles:10 Average:118.50 Median:109.50 stddev:16.39 (15.0%) stddev-sans-first:14.79 21:09:24 INFO - PROCESS | 1654 | Values: 143.0 109.0 109.0 146.0 107.0 110.0 109.0 108.0 137.0 107.0 21:09:24 INFO - PROCESS | 1654 | 21:09:24 INFO - PROCESS | 1654 | [#2] audio-dft Cycles:10 Average:193.20 Median:183.50 stddev:24.16 (13.2%) stddev-sans-first:25.28 21:09:24 INFO - PROCESS | 1654 | Values: 182.0 182.0 195.0 259.0 202.0 183.0 183.0 181.0 181.0 184.0 21:09:24 INFO - PROCESS | 1654 | 21:09:24 INFO - PROCESS | 1654 | [#3] audio-fft Cycles:10 Average:70.50 Median:61.50 stddev:17.53 (28.5%) stddev-sans-first:18.17 21:09:24 INFO - PROCESS | 1654 | Values: 81.0 60.0 73.0 112.0 63.0 59.0 58.0 59.0 83.0 57.0 21:09:24 INFO - PROCESS | 1654 | 21:09:24 INFO - PROCESS | 1654 | [#4] audio-oscillator Cycles:10 Average:88.20 Median:86.50 stddev:18.38 (21.3%) stddev-sans-first:19.49 21:09:24 INFO - PROCESS | 1654 | Values: 87.0 86.0 128.0 100.0 97.0 69.0 91.0 67.0 68.0 89.0 21:09:24 INFO - PROCESS | 1654 | 21:09:24 INFO - PROCESS | 1654 | [#5] imaging-gaussian-blur Cycles:10 Average:86.20 Median:86.50 stddev:1.75 (2.0%) stddev-sans-first:1.86 21:09:24 INFO - PROCESS | 1654 | Values: 86.0 86.0 87.0 84.0 88.0 85.0 89.0 85.0 88.0 84.0 21:09:24 INFO - PROCESS | 1654 | 21:09:24 INFO - PROCESS | 1654 | [#6] imaging-darkroom Cycles:10 Average:92.80 Median:93.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 21:09:24 INFO - PROCESS | 1654 | Values: 93.0 94.0 92.0 92.0 93.0 94.0 93.0 92.0 93.0 92.0 21:09:24 INFO - PROCESS | 1654 | 21:09:24 INFO - PROCESS | 1654 | [#7] imaging-desaturate Cycles:10 Average:84.70 Median:85.00 stddev:1.57 (1.8%) stddev-sans-first:1.42 21:09:24 INFO - PROCESS | 1654 | Values: 87.0 85.0 85.0 85.0 83.0 85.0 87.0 82.0 84.0 84.0 21:09:24 INFO - PROCESS | 1654 | 21:09:24 INFO - PROCESS | 1654 | [#8] json-parse-financial Cycles:10 Average:66.60 Median:75.50 stddev:16.02 (21.2%) stddev-sans-first:16.61 21:09:24 INFO - PROCESS | 1654 | Values: 57.0 51.0 54.0 73.0 87.0 47.0 52.0 78.0 78.0 89.0 21:09:24 INFO - PROCESS | 1654 | 21:09:24 INFO - PROCESS | 1654 | [#9] json-stringify-tinderbox Cycles:10 Average:69.30 Median:69.50 stddev:4.00 (5.8%) stddev-sans-first:3.54 21:09:24 INFO - PROCESS | 1654 | Values: 63.0 72.0 77.0 73.0 71.0 68.0 66.0 67.0 68.0 68.0 21:09:24 INFO - PROCESS | 1654 | 21:09:24 INFO - PROCESS | 1654 | [#10] stanford-crypto-aes Cycles:10 Average:82.80 Median:83.50 stddev:3.12 (3.7%) stddev-sans-first:3.28 21:09:24 INFO - PROCESS | 1654 | Values: 84.0 81.0 84.0 82.0 81.0 77.0 83.0 85.0 89.0 82.0 21:09:24 INFO - PROCESS | 1654 | 21:09:24 INFO - PROCESS | 1654 | [#11] stanford-crypto-ccm Cycles:10 Average:147.00 Median:150.00 stddev:15.16 (10.1%) stddev-sans-first:16.07 21:09:24 INFO - PROCESS | 1654 | Values: 146.0 166.0 136.0 133.0 132.0 134.0 156.0 154.0 175.0 138.0 21:09:24 INFO - PROCESS | 1654 | 21:09:24 INFO - PROCESS | 1654 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:165.90 Median:162.50 stddev:13.83 (8.5%) stddev-sans-first:1.67 21:09:24 INFO - PROCESS | 1654 | Values: 205.0 164.0 163.0 162.0 163.0 160.0 160.0 159.0 161.0 162.0 21:09:24 INFO - PROCESS | 1654 | 21:09:24 INFO - PROCESS | 1654 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.70 Median:66.00 stddev:1.06 (1.6%) stddev-sans-first:1.12 21:09:24 INFO - PROCESS | 1654 | Values: 66.0 66.0 66.0 64.0 66.0 68.0 65.0 66.0 65.0 65.0 21:09:24 INFO - PROCESS | 1654 | -------- Summary: end -------- 21:09:24 INFO - PROCESS | 1654 | 21:09:25 INFO - TEST-INFO | 1654: exit 0 21:09:25 INFO - TEST-OK | kraken | took 57754ms 21:09:25 INFO - SUITE-END | took 1172s 21:09:25 INFO - Completed test suite (00:19:32) 21:09:25 INFO - javascript benchmark 21:09:25 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3430.811305378205, 3445.104272889049, 3474.2704032153247, 3496.493008513767, 3510.350585141747, 5694.6867922264255, 5763.798267060653, 5767.538596912247, 5782.0, 5786.82639520814, 5727.885442291152, 5770.653760774357, 5793.391693872146, 5806.883862322751, 5808.448197421249, 5212.556932660728, 5255.658382205163, 5275.366955965271, 5316.73416329184, 5318.760655770499, 5219.295395121648, 5221.2951251580935, 5233.816816411427, 5383.219433182187, 5392.946070539284, 4770.117528257266, 4844.515548445145, 5279.366476022883, 5305.230741542474, 5328.866778330534, 5288.6562373445795, 5365.892682146375, 5366.0, 5368.4363141869935, 5371.301730775013, 5228.189630607262, 5267.736613169326, 5317.229001794718, 5320.308359913225, 5320.946790532123, 4620.468646105707, 5586.497215250647, 5634.802781902614, 5673.659580425187, 5676.631018983794, 4703.6942598730975, 6188.938110618881, 6229.0, 6231.563790534665, 6237.7816776413065, 6242.87514249717, 6258.436740693314, 6297.433231009185, 6308.968455157741, 6311.652859092748, 4726.409198850144, 5702.543796496312, 5739.569532285095, 5761.5102716269585, 5860.413958604106, 6253.312135665074, 6253.96873015632, 6272.090546870678, 6279.309275979638, 6287.339829317947, 5152.407473140562, 6205.6586887721605, 6234.0337247726675, 6247.843803904939, 6259.968700156561, 5018.774155163026, 6134.44789968896, 6180.412860778219, 6256.499480041586, 6306.653134077578, 6115.358579221981, 6163.9383606164265, 6167.537434692326, 6248.0, 6265.71804268809, 6256.968715156395, 6281.2462504498835, 6292.811215663537, 6297.6536290503545, 6305.8108256752375, 4846.103470857832, 5002.649814512949, 5012.373453318335, 5021.995600879839, 5040.243963405445, 4447.266201076851, 4451.310046942729, 4505.0, 4513.661475389359, 4527.094581083797, 5930.495907847881, 5930.911036334458, 5940.61386009908, 5946.70266486674, 5949.494292985145, 6276.843078922972, 6278.30938596754, 6296.118543403835, 6300.401461861115, 6307.495400368051, 5643.068893632587, 5735.741891614887, 5757.8560535986935, 5798.9420105799245, 5916.881662366729, 5429.701366424805, 5467.6719396836315, 5480.506754392124, 5482.890342193214, 5512.366077901012, 6358.682065896686, 6372.2353317601255, 6378.936210637927, 6395.072714456471, 6398.2322121344805, 6173.753049877954, 6224.439800417984, 6274.1843560336865, 6297.275813281348, 6305.306416294112, 6214.4407003369915, 6259.2488901332135, 6260.874782504234, 6264.718087686157, 6335.176427064452, 5212.582993360598, 6194.256689197326, 6195.752169913153, 6236.844078898064, 6252.124702541557, 6213.96893015532, 6270.561060725706, 6273.215022699235, 6278.560500765086, 6294.71673774672, 5961.195238642727, 6067.271927368744, 6093.329733729375, 6097.7865774697675, 6125.989211780006, 6204.751809927552, 6213.565050446426, 6217.09852071438, 6222.81331560054, 6223.533235007302, 5350.545203657733, 6086.300075491198, 6109.17526133984, 6110.2973158085615, 6115.3578874217565, 5972.850678732892, 5994.400559943971, 6098.586015328515, 6101.389861013863, 6124.0201567748945, 6006.309274433496, 6051.394860513913, 6061.818145455643, 6062.272527296753, 6096.603720758137], "value": 5712.719526394774, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [472.56760064540947, 497.4503173992738, 528.7462018231251, 538.9110796718542, 547.4580165636022, 32524.349513009725, 33183.00450986468, 33187.17032074196, 33254.66745332546, 34651.65348346516, 44279.89300267495, 45769.85575360609, 45852.54147458525, 47807.0, 47980.800479988015, 10013.549390277454, 10178.23663225261, 10192.0, 10193.490325483734, 10203.285769996104, 9289.44263344198, 9889.258305627107, 10002.099811017008, 10002.749931251741, 10002.899971000306, 9311.068893110669, 12239.632811015685, 12563.183393079466, 12566.99464042879, 12683.112182147208, 12481.687957801038, 12540.686482837911, 12545.74908501834, 12556.121071524996, 12561.811572826415, 12160.817587736192, 12236.694082647917, 12239.082068844784, 12247.326397048158, 12271.447784849703, 37594.8120259397, 41198.55805046809, 42777.35833962493, 43207.56792432067, 43209.567904320866, 3353.547271118392, 3412.522246885438, 3441.3117376524547, 3535.398982173011, 4199.286121359376, 25102.99588016477, 31522.842385788153, 31591.578378973, 32249.742518023748, 34105.0, 3103.7672174586996, 3207.0, 3211.1490455029434, 3254.040058182818, 3283.868645254187, 537921.0, 538038.0, 538215.0, 538412.3079384578, 539326.0, 35791.82104089463, 36852.44721329182, 62001.759964800454, 62116.37883621197, 62242.13273601799, 38056.42915356272, 38240.85277441681, 38264.80867595644, 38325.61674383276, 38347.2330553393, 15889.920550397173, 16047.117408542408, 16050.75923861143, 16071.598210044609, 16078.678426431406, 13358.532451364155, 13418.798718019238, 13428.0, 13447.596572102853, 13488.0, 7739.0, 7900.170482099296, 8164.6325915333955, 8263.173682631688, 8348.833023339499, 3359.5128706337446, 3409.335179639996, 3413.4026545354463, 3444.793312401264, 3445.1214940190093, 913.0777914306466, 926.6895589977433, 947.7111128864739, 973.8587904753771, 986.8075725233654, 31123.377532449224, 31989.68010319867, 32065.679343206735, 32110.678893211236, 32646.183845404055, 976.8778902637171, 1004.6282875336173, 1018.9861088217123, 1139.0602752728867, 1172.8592568891788, 13512.459501620022, 16498.845080844225, 16698.916505417394, 16785.32858685639, 17079.743803842954, 196178.0, 205151.97424013083, 205207.97396012925, 205407.0, 205681.0, 54328.72835635796, 55480.0, 62301.06548401687, 62808.68595656993, 63292.36707632957, 1404.262762049932, 1411.985880141206, 1453.9854601454063, 1454.8254209494928, 1457.992710036443, 27529.311767205178, 31183.0, 32728.67271327256, 33570.66429335676, 34275.82862085674, 56023.719881400335, 56624.15063774129, 56658.150127748944, 56695.58261043507, 56708.582285441546, 591146.0, 594484.0, 596487.0, 596951.0, 598129.0, 28641.28396790097, 28913.7108628911, 29190.854045729637, 29309.827606895484, 29332.266693332836, 49649.0, 49825.25262121144, 50054.0, 50412.747936260086, 51343.71640708863, 41156.79421602873, 42317.345369773815, 42696.7190984271, 42773.786131069144, 42833.78583107064, 41354.586454136275, 41413.58586414097, 42759.717208483795, 43563.34654980114, 44581.10837783291, 41175.7941210304, 41276.793616031726, 41741.79129104335, 42138.15723685448, 42148.73553793391, 34543.0, 35989.82005089958, 36933.0, 37093.62906370902, 37299.0, 27152.456950860476, 27287.454250915267, 27318.726812731617, 27343.86328068347, 27402.725972740816], "value": 19158.256544318476, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.854895139847, 386.63380113704136, 387.16565800699493, 393.84049459968713, 413.1633442279384, 19980.200791968324, 21380.786192138075, 21407.67888481674, 21595.46011349717, 22080.0, 20691.101986993133, 20709.0, 21184.57630847382, 21338.46653833655, 21614.3515694529, 4981.25281207819, 6183.319834818189, 6211.130441738161, 6243.90634140486, 6249.125122482856, 5421.864453388677, 5713.0, 6101.176341193948, 6185.381461853801, 6196.225471816023, 6074.0, 6087.421694938974, 6088.36072212418, 6097.085437184413, 6101.237345331833, 5802.941970580304, 6012.428819262207, 6056.818295451121, 6070.271567411917, 6085.600311928281, 5307.9734601326745, 5310.336207974004, 5314.681119132864, 5316.40507847648, 5317.175837745156, 25323.366915827068, 25336.0, 25425.618615720778, 25774.48451030969, 26041.73958260431, 2362.598358279097, 2390.5457962986975, 2482.838615489987, 2530.708968468631, 3140.3876244132402, 15247.0, 15497.690046199014, 15568.299426525833, 16367.754483682755, 16407.507774766775, 1755.9385421510315, 1908.9119202054835, 1937.2638397409034, 1943.9028048597654, 1946.4452631000097, 76141.85787213141, 116742.83257167405, 121094.39452802768, 125972.37013814872, 127451.0, 9462.952685236529, 10400.27198096126, 10739.83890241647, 10776.29954052984, 10816.459177041117, 13945.860541394457, 13948.0, 13951.790723139162, 13956.790648140286, 13963.79054314186, 8555.443896146731, 8761.605727742139, 8769.298456123623, 8856.335774816915, 8893.28853691703, 7410.407167426593, 8893.4663920165, 8918.643254269757, 8926.946802235521, 9079.863802042975, 6475.579087359307, 6599.91101468262, 6607.9669601651685, 6609.074729537869, 6613.710326486289, 1818.6362727454562, 1836.0819590204896, 1843.889366638006, 1845.2987864611362, 1848.6672398968315, 865.6191275838611, 923.9491827949392, 952.9422341201262, 994.3536701144315, 1025.5026312238558, 22094.447638809157, 22654.886725566266, 22880.885595571915, 22908.198213062464, 23040.769592304197, 952.4856577448239, 963.5519483440233, 980.4313498171043, 995.6266400099962, 1046.1108058150512, 11107.944460277648, 11840.407979600985, 11911.642650720492, 11950.223235489839, 12019.63941081769, 588650.0, 614861.0, 620145.0, 622749.0, 633358.0, 86952.56523717467, 87576.12423875679, 93010.60484092744, 94022.5298873515, 126017.0, 1004.718678769931, 1068.834330678746, 1115.286216821235, 1116.2967330581682, 1119.9160062995309, 20296.492587685425, 20445.89777051165, 21025.789742102384, 21053.0, 21069.0, 37141.62858371382, 47303.0, 53048.4695153059, 55041.72479137579, 55385.72307138438, 69461.30538694751, 84246.0, 85952.0, 85955.0, 86920.1307986912, 7929.127795942326, 8103.0, 8200.58997050157, 8216.56210163231, 8260.917390826255, 11890.702732431759, 12561.623151305475, 12644.0, 12726.68183295425, 13067.934660327019, 5358.892822143457, 5845.590808643354, 9541.568764685353, 11208.831867522156, 11467.483963221843, 9780.462074585967, 10726.356418614909, 10928.486448116819, 10995.945020274847, 11012.39431831257, 11232.83150752723, 11255.718607034889, 11333.206675532634, 11503.964643182153, 11582.594609188638, 7903.644336004779, 8085.151059138706, 8105.392095592736, 8212.384071194565, 8244.711435099744, 8202.09776924526, 10507.00183482568, 10908.236423450282, 11330.320180789178, 11543.249688770204], "value": 9792.7979169067, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1381.6545863534116, 1521.0873475914452, 1735.6615459985308, 1922.7596550431197, 1954.9315773947915, 8612.483251004944, 9154.404963677365, 9161.587728552215, 9177.724668259954, 9203.953980230106, 6845.315468453152, 6908.412784913288, 7087.53930994485, 8411.453255538401, 8625.87061194081, 2387.2957477544123, 2411.6503107049466, 2419.5765740995344, 2419.758024197584, 2420.177139772477, 2373.371056669984, 2378.4648454097864, 2415.2150551070886, 2415.698037745282, 2424.103081859714, 2407.0732767884315, 2413.7706917842775, 2425.151197081025, 2428.441458464554, 2433.561958847407, 2386.880655967195, 2395.4610212702178, 2403.495265994152, 2406.4585468269674, 2412.179858848, 2384.0106355862295, 2395.173665085543, 2399.940001499959, 2404.5912194926905, 2407.4462873539183, 8740.956295218482, 8829.249513791336, 8842.734717958472, 8986.68546600866, 9137.908620913839, 5384.623076384654, 5540.584456165804, 5557.194206840026, 5559.749811258503, 5565.833025009256, 3524.823758812049, 3642.289753498069, 3689.4465830125428, 3695.4456831475495, 3730.925381492355, 1098.3849044535007, 1098.8846171151995, 1100.5927806711488, 1115.4311301236428, 1125.8142406502918, 11933.761324773543, 11960.880391196064, 12014.459349329214, 12044.21712588679, 12061.698457538543, 3960.821763020671, 4496.527864574238, 4541.091781643619, 4731.432228132578, 4731.645126615517, 9275.443473391619, 9279.489628070385, 9282.814343713088, 9308.255339572817, 9309.813803723888, 5316.388615309212, 5323.760430780624, 5329.866753331198, 5339.279197308391, 5341.412444631087, 4550.249208880564, 4704.811807527661, 4902.289168070681, 4984.177610694267, 4994.350734404504, 3853.653171214548, 3872.5740168581433, 3951.8024098794945, 3962.9009274767786, 3983.2630963271886, 1153.4578747988432, 1164.441068287227, 1164.5109054197258, 1184.768970050849, 1185.4487663236637, 782.9765107046798, 863.9955303695492, 889.7375274294099, 910.7814124610178, 913.9946059334811, 5807.361190269067, 5829.970850145807, 5836.533077353802, 6114.419130182714, 6162.291336496271, 896.8385940207447, 913.584319134792, 929.2612373163216, 947.7630592351912, 1003.5885287032428, 3494.2836718472654, 3908.7459315144993, 3946.427767973628, 3960.663343615767, 4095.0990782027907, 10622.0, 11096.167787415976, 11100.333979961228, 11104.000639942444, 11142.554297828157, 11020.173486988508, 11044.33733975964, 11044.834327485094, 11046.281991670516, 11092.556297748, 8023.1575684553445, 8264.132266112092, 8388.783626374263, 8394.412391132562, 8517.276031537265, 5969.3345903836, 5973.701314934149, 6040.244969378828, 6173.444390004921, 6173.783917562864, 10141.645042423479, 10312.432816195182, 10398.844017339898, 10420.739481513023, 10437.373757574569, 10286.382817031003, 10346.793064138825, 10463.162946964378, 10469.633562825264, 10490.213234007328, 7093.964530177316, 7300.926990730025, 7304.890426643711, 7763.68945242184, 7856.37149028065, 7869.527828330319, 8078.87881681787, 8428.747137585882, 8570.785730356542, 8725.127487251224, 7604.505707129019, 7758.8448231033935, 7762.728304509315, 7809.492382995087, 7849.1758365370815, 7517.624118794148, 7602.695892164252, 7642.541447513167, 7684.0, 7817.609119544114, 6189.257289125334, 7129.322714342129, 7213.134423868959, 7240.384567311627, 7245.963770181115, 4891.315215869852, 4936.770670360488, 4987.326710893983, 5049.444561098349, 5103.540681338697, 5052.5705315048635, 5068.113080210875, 5202.0, 5221.112410890082, 5252.054630166606], "value": 4632.261285057243, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [270.02520899552616, 312.97809153359276, 316.0502689418297, 322.89505910579066, 326.9836508174591, 4554.931676024854, 4668.346431499588, 5382.757775900084, 5527.861803454915, 5602.271704678396, 4236.682248831335, 4354.499232588253, 4459.353393757903, 4471.5629981659995, 5451.672899626015, 3367.478040903664, 3876.6704830089475, 3997.5802540733166, 4193.630598711733, 4256.59562341577, 4222.472190976128, 4256.254935476455, 4263.2965560682605, 4268.935965960498, 4287.742735435868, 4051.837926482952, 4186.0, 4222.028933345332, 4235.280002399584, 4240.512341080785, 4202.516710578277, 4204.222218889515, 4206.242876282268, 4207.663386929038, 4239.622122810084, 3674.5590529136407, 3682.6869716073898, 3699.5375578052744, 3704.1850792825535, 3705.907352316187, 4584.6561507887045, 5029.547340739315, 5345.636862600051, 5385.5960802939935, 5385.623006389555, 4817.566419022305, 4817.7591120444185, 4821.0, 4822.638302127354, 4845.442774080955, 4820.421549414058, 5660.433956604348, 5706.715988902505, 5727.914081288784, 5778.8266352009505, 3716.888493345204, 3893.3965235388278, 4061.208064427438, 4092.7544347339253, 4097.098638299599, 5435.374931882845, 5761.436160908397, 5957.09810074402, 6051.394860513913, 6056.424639659225, 3509.5437593113243, 4149.647279981235, 4158.629581138722, 4160.167966406731, 4164.917541229324, 3995.9400608990886, 4234.301340278819, 4234.87295381139, 4261.680373971964, 4271.444712187395, 3689.9077523062138, 4217.325227963511, 4317.956820431818, 4652.395188625457, 4849.684770489906, 5775.653460792366, 5795.478406943311, 5809.622374545641, 5842.8539286517325, 5843.678597677083, 1266.8479782426168, 1338.6519504928594, 1421.374595178139, 1451.8548145185607, 1462.4515806572535, 696.8989496522976, 801.3052394186254, 868.9478631282017, 892.7991850960448, 897.5736525150501, 4614.131276832888, 4649.744264065509, 4652.767361631905, 4669.34629151919, 4744.952550474451, 4953.975230123826, 4974.90050198994, 4981.975090124599, 5008.749562521859, 5040.899182016339, 4311.9784401077795, 4369.269206745784, 4474.172278128557, 4634.073185362941, 4694.2723877799, 2226.4062367341867, 2361.397843549884, 2417.3231495181376, 2601.91846522781, 2612.1902210314865, 4347.782630858285, 4574.656900732459, 4619.40630482483, 4909.3126962225315, 4950.034743225108, 4807.759612019385, 5023.79904803811, 5036.722980236049, 5454.372747134051, 6188.938110618837, 5121.564667003347, 6149.864862839489, 6177.6911154443, 6188.783392581238, 6199.5660303779205, 4848.490908454562, 5497.945020549743, 5797.79707710245, 5969.0, 6051.727672254671, 5126.4617215191865, 5440.238366628596, 5576.800987787645, 5704.258446402107, 5893.261487861006, 5622.971885140548, 5882.205902203319, 6185.226846644169, 6194.5973511721595, 6208.379162083756, 3848.4034974578985, 4003.11931375097, 4019.4774679291504, 4019.577944315805, 4033.91932161361, 5575.386707462095, 5939.524838013035, 5971.790987315423, 5980.302061690934, 6008.0, 4873.853784386474, 5388.784448622011, 5625.831225063254, 5838.32859221178, 5939.346671866005, 4906.313116163668, 5310.787568497217, 5578.884223155466, 5825.378579639264, 5846.503047241032, 4665.4634717007975, 4956.727379994135, 5694.544436445157, 5702.8289151325525, 5707.229524014371, 5653.378128405954, 5859.560532959959, 5868.911966320594, 5871.559633027455, 5890.6760128191645, 4819.927701084416, 5754.4533269339345, 5765.8558536036935, 5766.895083294651, 5826.621269617631], "value": 4097.428256705399, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [714.3142583120205, 755.7203834581204, 803.4295650088437, 817.3461231015186, 845.602566793607, 16012.599685007866, 17250.137493125356, 17314.56713582161, 17323.82676173236, 17346.826531734696, 14582.416703331854, 14634.926825365857, 14640.780388294157, 14652.853471465281, 14655.633609159777, 703.2159142556064, 723.6671131279618, 725.3182008911632, 730.7844185965153, 862.7109918177418, 727.3526561360394, 729.6716477585081, 869.8738682891009, 895.3240303570794, 900.4372267332917, 937.6999360204737, 945.9763505912339, 950.4629884115452, 953.4136506048765, 955.1451450951395, 946.9337146399789, 948.7628092976756, 949.5157469690439, 950.1923365139645, 950.4629884115452, 706.6502081469705, 711.3668834737089, 712.6971037309123, 712.7683502861539, 717.0105254748466, 15691.843081569266, 15868.0, 15912.283947222402, 15916.840831591768, 15926.840731592767, 13422.798658020138, 13568.253746043963, 13581.660458488517, 13999.790003149961, 14041.368138433794, 13130.671733206651, 13316.467341306434, 13506.257155856423, 13648.522301719393, 13687.726245475034, 4656.837010704609, 4716.764161791897, 4746.121967436035, 4757.405324334458, 4882.36529251195, 120466.0, 121991.39004304922, 126115.0, 130332.0, 133172.33413832868, 11040.613578524713, 11225.270357426905, 11330.433478326051, 11418.371989540488, 11758.706032349088, 21942.0, 21994.670079948814, 22129.55740885173, 22132.557348852934, 22313.888430557745, 8060.435769496079, 8098.230668086522, 8148.22591853773, 8159.510429374256, 8261.215184557457, 4491.618212451913, 4534.818607255673, 4704.458987216445, 4736.0, 4853.684510506806, 3615.295017471568, 3743.9812800936365, 3772.2832661794173, 3774.433834924728, 3779.4897688812207, 670.4301343857682, 678.4470656415006, 684.6029303004345, 690.1200968764765, 690.5649440852231, 571.8884817460638, 595.6574969392617, 645.7158850105939, 704.9777822157789, 710.2400431538308, 8697.478151310941, 9914.900850991398, 10053.346532475365, 10084.69745907624, 10212.846807297896, 652.438902543812, 672.4754691340762, 692.4183685704032, 699.8320403103219, 712.8217945513621, 4397.956020439755, 4713.929291060636, 4738.222892615835, 4907.190313598217, 5138.396871848117, 140458.2977085108, 158096.20951895165, 161566.0, 162739.0, 165815.0, 136801.31599341938, 141896.0, 142599.0, 143877.5612243885, 146538.26730866276, 89056.9999999987, 111086.88913110927, 124135.0, 124144.0, 125936.0, 10362.430066346424, 10375.740606484898, 10650.8402373966, 10687.946560267148, 10697.732556686145, 66758.66620666865, 67475.66262168658, 67824.6608766953, 70639.0, 70656.0, 99612.0, 101106.98893010976, 104934.0, 105250.0, 112138.87861121284, 13201.801972970221, 13596.98022648325, 13707.657308567366, 13781.448742050206, 13965.720685586028, 14895.627609309853, 15026.924865375604, 15111.244437777847, 15512.84487155114, 15970.68058638844, 14024.579262622137, 14063.226522541358, 14373.7843932339, 14473.782893256399, 14477.638059048608, 14013.229272390117, 14653.340599673253, 14877.553673389815, 15024.17367044823, 15052.473163439226, 14124.0, 14207.218602976522, 14378.065425747292, 14739.041962272418, 15223.391064357302, 11391.177411614102, 11726.296422214353, 11869.169158158846, 11976.401179941142, 12132.757344852876, 11808.586699465477, 11854.762904742029, 12082.516699331929, 12125.211861228992, 12182.269063855843], "value": 8302.729621250715, "unit": "score"}], "name": "dromaeo_css", "value": 7434.970754897445, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 114.0, 115.0, 113.0, 113.0, 114.0, 114.0, 114.0, 114.0], "value": 114.0, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 109.0, 109.0, 146.0, 107.0, 110.0, 109.0, 108.0, 137.0, 107.0], "value": 118.5, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [182.0, 182.0, 195.0, 259.0, 202.0, 183.0, 183.0, 181.0, 181.0, 184.0], "value": 193.2, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 60.0, 73.0, 112.0, 63.0, 59.0, 58.0, 59.0, 83.0, 57.0], "value": 70.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 128.0, 100.0, 97.0, 69.0, 91.0, 67.0, 68.0, 89.0], "value": 88.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 84.0, 88.0, 85.0, 89.0, 85.0, 88.0, 84.0], "value": 86.2, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 92.0, 92.0, 93.0, 94.0, 93.0, 92.0, 93.0, 92.0], "value": 92.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 85.0, 85.0, 85.0, 83.0, 85.0, 87.0, 82.0, 84.0, 84.0], "value": 84.7, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 51.0, 54.0, 73.0, 87.0, 47.0, 52.0, 78.0, 78.0, 89.0], "value": 66.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [63.0, 72.0, 77.0, 73.0, 71.0, 68.0, 66.0, 67.0, 68.0, 68.0], "value": 69.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 81.0, 84.0, 82.0, 81.0, 77.0, 83.0, 85.0, 89.0, 82.0], "value": 82.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [146.0, 166.0, 136.0, 133.0, 132.0, 134.0, 156.0, 154.0, 175.0, 138.0], "value": 147.0, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [205.0, 164.0, 163.0, 162.0, 163.0, 160.0, 160.0, 159.0, 161.0, 162.0], "value": 165.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 66.0, 64.0, 66.0, 68.0, 65.0, 66.0, 65.0, 65.0], "value": 65.7, "unit": "score"}], "name": "kraken", "value": 1445.4, "alertThreshold": 2.0}]} 21:09:25 INFO - Return code: 0 21:09:25 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 21:09:25 INFO - # TBPL SUCCESS # 21:09:25 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 21:09:25 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 21:09:25 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 21:09:26 INFO - 2017-01-02 21:09:26.000 screenresolution[1658:10453] starting screenresolution argv=screenresolution get 21:09:26 INFO - 2017-01-02 21:09:26.003 screenresolution[1658:10453] Display 0: 1600x1200x32@60 21:09:26 INFO - 2017-01-02 21:09:26.008 screenresolution[1659:10456] starting screenresolution argv=screenresolution list 21:09:26 INFO - Available Modes on Display 0 21:09:26 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 21:09:26 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 21:09:26 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 21:09:26 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 21:09:26 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 21:09:26 INFO - Intel Iris: 21:09:26 INFO - Chipset Model: Intel Iris 21:09:26 INFO - Type: GPU 21:09:26 INFO - Bus: Built-In 21:09:26 INFO - VRAM (Dynamic, Max): 1536 MB 21:09:26 INFO - Vendor: Intel (0x8086) 21:09:26 INFO - Device ID: 0x0a2e 21:09:26 INFO - Revision ID: 0x0009 21:09:26 INFO - Displays: 21:09:26 INFO - Display: 21:09:26 INFO - Resolution: 1600 x 1200 @ 60 Hz 21:09:26 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 21:09:26 INFO - Display Serial Number: 1600x1200 60 21:09:26 INFO - Main Display: Yes 21:09:26 INFO - Mirror: Off 21:09:26 INFO - Online: Yes 21:09:26 INFO - Rotation: Supported 21:09:26 INFO - Return code: 0 21:09:26 INFO - Running post-action listener: _resource_record_post_action 21:09:26 INFO - [mozharness: 2017-01-03 05:09:26.243601Z] Finished run-tests step (success) 21:09:26 INFO - Running post-run listener: _resource_record_post_run 21:09:26 INFO - Total resource usage - Wall time: 1195s; CPU: 53.0%; Read bytes: 33635328; Write bytes: 495934976; Read time: 317; Write time: 1657 21:09:26 INFO - TinderboxPrint: CPU usage
53.1% 21:09:26 INFO - TinderboxPrint: I/O read bytes / time
33,635,328 / 317 21:09:26 INFO - TinderboxPrint: I/O write bytes / time
495,934,976 / 1,657 21:09:26 INFO - TinderboxPrint: CPU idle
2,240.9 (46.9%) 21:09:26 INFO - TinderboxPrint: CPU system
949.7 (19.9%) 21:09:26 INFO - TinderboxPrint: CPU user
1,590.9 (33.3%) 21:09:26 INFO - TinderboxPrint: Swap in / out
225,488,896 / 0 21:09:26 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 194726400; Write bytes: 188762112; Read time: 17823; Write time: 390 21:09:26 INFO - run-tests - Wall time: 1174s; CPU: 53.0%; Read bytes: 29268992; Write bytes: 296785408; Read time: 282; Write time: 1231 21:09:26 INFO - Running post-run listener: _upload_blobber_files 21:09:26 INFO - Blob upload gear active. 21:09:26 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 21:09: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 21:09: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', 'Mozilla-Beta', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 21:09: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 Mozilla-Beta -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 21:09:27 INFO - (blobuploader) - INFO - Open directory for files ... 21:09:27 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 21:09:27 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:09:27 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:09:28 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 21:09:28 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:09:28 INFO - (blobuploader) - INFO - Done attempting. 21:09:28 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 21:09:28 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:09:28 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:09:29 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 21:09:29 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:09:29 INFO - (blobuploader) - INFO - Done attempting. 21:09:29 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 21:09:29 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 21:09:29 INFO - (blobuploader) - INFO - Uploading, attempt #1. 21:09:31 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 21:09:31 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 21:09:31 INFO - (blobuploader) - INFO - Done attempting. 21:09:31 INFO - (blobuploader) - INFO - Iteration through files over. 21:09:31 INFO - Return code: 0 21:09:31 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 21:09:31 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 21:09:31 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2efe7a24602b130c359876954c92d9352bdd49d649c6bcf72fef5689cf0fa977d89755a3edca3d3eea0199dc708f05dc081e227144f5e86fdf93468cca4a6e42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d03ce51c1f409aed75817e7830c92cdae7d9b971b103e852a4a5df5dc0c8ff87b2a01230db59a678fab5ec70a8fe77bda9e9d54f5be564b7d2508deb424cf66a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03001e9c65905d419e2541cda435db1e5af1d9233125c2df8cf1e8c21b767b8eeb235beeb3f39d8fca7b0f379677d3697680b6ea2a8665a2336b5a7ac739e11c"} 21:09:31 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 21:09:31 INFO - Writing to file /builds/slave/test/properties/blobber_files 21:09:31 INFO - Contents: 21:09:31 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2efe7a24602b130c359876954c92d9352bdd49d649c6bcf72fef5689cf0fa977d89755a3edca3d3eea0199dc708f05dc081e227144f5e86fdf93468cca4a6e42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d03ce51c1f409aed75817e7830c92cdae7d9b971b103e852a4a5df5dc0c8ff87b2a01230db59a678fab5ec70a8fe77bda9e9d54f5be564b7d2508deb424cf66a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03001e9c65905d419e2541cda435db1e5af1d9233125c2df8cf1e8c21b767b8eeb235beeb3f39d8fca7b0f379677d3697680b6ea2a8665a2336b5a7ac739e11c"} 21:09:31 INFO - Running post-run listener: copy_logs_to_upload_dir 21:09:31 INFO - Copying logs to upload dir... 21:09:31 INFO - mkdir: /builds/slave/test/build/upload/logs 21:09:31 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1255.238709 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 20 mins, 55 secs) (at 2017-01-02 21:09:31.649254) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 21:09:31.653326) ========= 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.xsRqtn23Of/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.0osfaTwA9E/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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/Mozilla-Beta/sha512/2efe7a24602b130c359876954c92d9352bdd49d649c6bcf72fef5689cf0fa977d89755a3edca3d3eea0199dc708f05dc081e227144f5e86fdf93468cca4a6e42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d03ce51c1f409aed75817e7830c92cdae7d9b971b103e852a4a5df5dc0c8ff87b2a01230db59a678fab5ec70a8fe77bda9e9d54f5be564b7d2508deb424cf66a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03001e9c65905d419e2541cda435db1e5af1d9233125c2df8cf1e8c21b767b8eeb235beeb3f39d8fca7b0f379677d3697680b6ea2a8665a2336b5a7ac739e11c"} build_url:https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010983 build_url: 'https://queue.taskcluster.net/v1/task/I73ACqroQaGrdzSX4A3ijw/artifacts/public/build/firefox-51.0.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/2efe7a24602b130c359876954c92d9352bdd49d649c6bcf72fef5689cf0fa977d89755a3edca3d3eea0199dc708f05dc081e227144f5e86fdf93468cca4a6e42", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/d03ce51c1f409aed75817e7830c92cdae7d9b971b103e852a4a5df5dc0c8ff87b2a01230db59a678fab5ec70a8fe77bda9e9d54f5be564b7d2508deb424cf66a", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Beta/sha512/03001e9c65905d419e2541cda435db1e5af1d9233125c2df8cf1e8c21b767b8eeb235beeb3f39d8fca7b0f379677d3697680b6ea2a8665a2336b5a7ac739e11c"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-02 21:09:31.689371) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 21:09:31.689770) ========= 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.xsRqtn23Of/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.0osfaTwA9E/Listeners TMPDIR=/var/folders/pq/9wq8k9b96lz0dzpzk0df56pw00000w/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.005222 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-02 21:09:31.741933) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 21:09:31.742714) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-02 21:09:31.743445) ========= ========= Total master_lag: 0.19 =========