builder: mozilla-aurora_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0327 starttime: 1485262814.52 results: success (0) buildid: 20170124032343 builduid: ae4180d3a1b2467b9d8ba6f3404675c7 revision: 5d14c6efd4bab1bb849db13238bf95a3a06b1d9e ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 05:00:14.524190) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-24 05:00:14.524621) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 05:00:14.524899) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-24 05:00:14.551026) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 05:00:14.551443) ========= 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.z4BZLI55DC/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.tnpbOvPEwZ/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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-24 05:00:14-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 161M=0s 2017-01-24 05:00:14 (161 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.122603 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 05:00:14.698082) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 05:00:14.698405) ========= 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.z4BZLI55DC/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.tnpbOvPEwZ/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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.024306 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 05:00:14.747233) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 05:00:14.750617) ========= bash -c 'python archiver_client.py mozharness --repo releases/mozilla-aurora --rev 5d14c6efd4bab1bb849db13238bf95a3a06b1d9e --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-aurora --rev 5d14c6efd4bab1bb849db13238bf95a3a06b1d9e --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.z4BZLI55DC/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.tnpbOvPEwZ/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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-24 05:00:14,864 truncating revision to first 12 chars 2017-01-24 05:00:14,864 Setting DEBUG logging. 2017-01-24 05:00:14,864 attempt 1/10 2017-01-24 05:00:14,864 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/releases/mozilla-aurora/5d14c6efd4ba?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-24 05:00:16,408 unpacking tar archive at: mozilla-aurora-5d14c6efd4ba/testing/mozharness/ program finished with exit code 0 elapsedTime=1.825492 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-24 05:00:16.602587) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 05:00:16.602931) ========= script_repo_revision: 5d14c6efd4bab1bb849db13238bf95a3a06b1d9e ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-24 05:00:16.603341) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 05:00:16.603625) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-24 05:00:16.623981) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-24 05:00:16.624352) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 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-Aurora', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Mozilla-Aurora'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.z4BZLI55DC/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.tnpbOvPEwZ/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 05:00:16 INFO - MultiFileLogger online at 20170124 05:00:16 in /builds/slave/test 05:00:16 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Mozilla-Aurora --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Mozilla-Aurora 05:00:16 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:00:16 INFO - {'append_to_log': False, 05:00:16 INFO - 'base_work_dir': '/builds/slave/test', 05:00:16 INFO - 'blob_upload_branch': 'Mozilla-Aurora', 05:00:16 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:00:16 INFO - 'branch': 'Mozilla-Aurora', 05:00:16 INFO - 'buildbot_json_path': 'buildprops.json', 05:00:16 INFO - 'config_files': ('talos/mac_config.py',), 05:00:16 INFO - 'default_actions': ('clobber', 05:00:16 INFO - 'read-buildbot-config', 05:00:16 INFO - 'download-and-extract', 05:00:16 INFO - 'populate-webroot', 05:00:16 INFO - 'create-virtualenv', 05:00:16 INFO - 'install', 05:00:16 INFO - 'run-tests'), 05:00:16 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:00:16 INFO - 'download_minidump_stackwalk': True, 05:00:16 INFO - 'download_symbols': 'ondemand', 05:00:16 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:00:16 INFO - 'tooltool.py': '/tools/tooltool.py', 05:00:16 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:00:16 INFO - '/tools/misc-python/virtualenv.py')}, 05:00:16 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:00:16 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:00:16 INFO - 'installer_path': 'installer.exe', 05:00:16 INFO - 'log_level': 'info', 05:00:16 INFO - 'log_name': 'talos', 05:00:16 INFO - 'log_to_console': True, 05:00:16 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:00:16 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:00:16 INFO - 'opt_config_files': (), 05:00:16 INFO - 'pip_index': False, 05:00:16 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:00:16 INFO - 'cmd': ('bash', 05:00:16 INFO - '-c', 05:00:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:00:16 INFO - 'enabled': True, 05:00:16 INFO - 'halt_on_failure': False, 05:00:16 INFO - 'name': 'check_screen_resolution'},), 05:00:16 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:00:16 INFO - 'cmd': ('bash', 05:00:16 INFO - '-c', 05:00:16 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:00:16 INFO - 'enabled': True, 05:00:16 INFO - 'halt_on_failure': False, 05:00:16 INFO - 'name': 'check_screen_resolution'},), 05:00:16 INFO - 'run_cmd_checks_enabled': True, 05:00:16 INFO - 'sps_profile': False, 05:00:16 INFO - 'sps_profile_interval': 0, 05:00:16 INFO - 'suite': 'dromaeojs', 05:00:16 INFO - 'system_bits': '32', 05:00:16 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:00:16 INFO - 'title': 't-yosemite-r7-0327', 05:00:16 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:00:16 INFO - 'use_talos_json': True, 05:00:16 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:00:16 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:00:16 INFO - 'work_dir': 'build'} 05:00:16 INFO - [mozharness: 2017-01-24 13:00:16.844105Z] Running clobber step. 05:00:16 INFO - Running pre-action listener: _resource_record_pre_action 05:00:16 INFO - Running main action method: clobber 05:00:16 INFO - rmtree: /builds/slave/test/build 05:00:16 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:00:19 INFO - Running post-action listener: _resource_record_post_action 05:00:19 INFO - [mozharness: 2017-01-24 13:00:19.104233Z] Finished clobber step (success) 05:00:19 INFO - [mozharness: 2017-01-24 13:00:19.104336Z] Running read-buildbot-config step. 05:00:19 INFO - Running pre-action listener: _resource_record_pre_action 05:00:19 INFO - Running main action method: read_buildbot_config 05:00:19 INFO - Using buildbot properties: 05:00:19 INFO - { 05:00:19 INFO - "project": "", 05:00:19 INFO - "product": "firefox", 05:00:19 INFO - "script_repo_revision": "production", 05:00:19 INFO - "builddir": "mozilla-aurora_yosemite_r7_test-dromaeojs", 05:00:19 INFO - "repository": "", 05:00:19 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-aurora talos dromaeojs", 05:00:19 INFO - "buildid": "20170124032343", 05:00:19 INFO - "pgo_build": "False", 05:00:19 INFO - "basedir": "/builds/slave/test", 05:00:19 INFO - "buildnumber": 40, 05:00:19 INFO - "slavename": "t-yosemite-r7-0327", 05:00:19 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 05:00:19 INFO - "platform": "yosemite_r7", 05:00:19 INFO - "scheduler": "tests-mozilla-aurora-macosx64-talos", 05:00:19 INFO - "branch": "mozilla-aurora", 05:00:19 INFO - "repo_path": "releases/mozilla-aurora", 05:00:19 INFO - "revision": "5d14c6efd4bab1bb849db13238bf95a3a06b1d9e", 05:00:19 INFO - "stage_platform": "macosx64", 05:00:19 INFO - "builduid": "ae4180d3a1b2467b9d8ba6f3404675c7", 05:00:19 INFO - "slavebuilddir": "test" 05:00:19 INFO - } 05:00:19 INFO - Found installer url https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg. 05:00:19 INFO - Running post-action listener: _resource_record_post_action 05:00:19 INFO - [mozharness: 2017-01-24 13:00:19.108019Z] Finished read-buildbot-config step (success) 05:00:19 INFO - [mozharness: 2017-01-24 13:00:19.108230Z] Running download-and-extract step. 05:00:19 INFO - Running pre-action listener: _resource_record_pre_action 05:00:19 INFO - Running main action method: download_and_extract 05:00:19 INFO - mkdir: /builds/slave/test/build/tests 05:00: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')]} 05:00:19 INFO - trying https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json 05:00:19 INFO - Downloading https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 05:00:19 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json'}, attempt #1 05:00:20 INFO - Downloaded 1199 bytes. 05:00:20 INFO - Reading from file /builds/slave/test/build/firefox-53.0a2.en-US.mac.test_packages.json 05:00:20 INFO - Using the following test package requirements: 05:00:20 INFO - {u'common': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 05:00:20 INFO - u'cppunittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:00:20 INFO - u'firefox-53.0a2.en-US.mac.cppunittest.tests.zip'], 05:00:20 INFO - u'gtest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:00:20 INFO - u'firefox-53.0a2.en-US.mac.gtest.tests.zip'], 05:00:20 INFO - u'jittest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:00:20 INFO - u'jsshell-mac.zip'], 05:00:20 INFO - u'mochitest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:00:20 INFO - u'firefox-53.0a2.en-US.mac.mochitest.tests.zip'], 05:00:20 INFO - u'mozbase': [u'firefox-53.0a2.en-US.mac.common.tests.zip'], 05:00:20 INFO - u'reftest': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:00:20 INFO - u'firefox-53.0a2.en-US.mac.reftest.tests.zip'], 05:00:20 INFO - u'talos': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:00:20 INFO - u'firefox-53.0a2.en-US.mac.talos.tests.zip'], 05:00:20 INFO - u'web-platform': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:00:20 INFO - u'firefox-53.0a2.en-US.mac.web-platform.tests.zip'], 05:00:20 INFO - u'xpcshell': [u'firefox-53.0a2.en-US.mac.common.tests.zip', 05:00:20 INFO - u'firefox-53.0a2.en-US.mac.xpcshell.tests.zip']} 05:00:20 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip'] for test suite category: common 05:00:20 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 05:00:20 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:00:20 INFO - Fetch https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 05:00:20 INFO - Expected file size: 16349467 05:00:20 INFO - Obtained file size: 16349467 05:00:27 INFO - Downloading packages: [u'firefox-53.0a2.en-US.mac.common.tests.zip', u'firefox-53.0a2.en-US.mac.talos.tests.zip'] for test suite category: talos 05:00:27 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip 05:00:27 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip'}, attempt #1 05:00:27 INFO - Fetch https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.common.tests.zip into memory 05:00:28 INFO - Expected file size: 16349467 05:00:28 INFO - Obtained file size: 16349467 05:00:35 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip 05:00:35 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip'}, attempt #1 05:00:35 INFO - Fetch https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.talos.tests.zip into memory 05:00:36 INFO - Expected file size: 14403485 05:00:36 INFO - Obtained file size: 14403485 05:00:36 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')]} 05:00:36 INFO - trying https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 05:00:36 INFO - Downloading https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg to /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg 05:00:36 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg'}, attempt #1 05:00:38 INFO - Downloaded 73888358 bytes. 05:00:38 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 05:00:38 INFO - mkdir: /builds/slave/test/properties 05:00:38 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:00:38 INFO - Writing to file /builds/slave/test/properties/build_url 05:00:38 INFO - Contents: 05:00:38 INFO - build_url:https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg 05:00:39 INFO - Running post-action listener: _resource_record_post_action 05:00:39 INFO - Running post-action listener: set_extra_try_arguments 05:00:39 INFO - [mozharness: 2017-01-24 13:00:39.516114Z] Finished download-and-extract step (success) 05:00:39 INFO - [mozharness: 2017-01-24 13:00:39.516280Z] Running populate-webroot step. 05:00:39 INFO - Running pre-action listener: _resource_record_pre_action 05:00:39 INFO - Running main action method: populate_webroot 05:00:39 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:00:39 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:00:39 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:00:39 INFO - '--tppagecycles', 05:00:39 INFO - '7'], 05:00:39 INFO - 'tests': ['tsvgm']}}, 05:00:39 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:00:39 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:00:39 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:00:39 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:00:39 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:00:39 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:00:39 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:00:39 INFO - 'talos_options': ['--disable-e10s'], 05:00:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:39 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:00:39 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:00:39 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:00:39 INFO - 'talos_options': ['--disable-e10s'], 05:00:39 INFO - 'tests': ['damp', 'tps']}, 05:00:39 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:00:39 INFO - 'tests': ['damp', 'tps']}, 05:00:39 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:00:39 INFO - 'tests': ['dromaeo_dom']}, 05:00:39 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:00:39 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:00:39 INFO - 'tests': ['basic_compositor_video']}, 05:00:39 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:00:39 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:00:39 INFO - 'tests': ['a11yr', 05:00:39 INFO - 'ts_paint', 05:00:39 INFO - 'tpaint', 05:00:39 INFO - 'sessionrestore', 05:00:39 INFO - 'sessionrestore_no_auto_restore', 05:00:39 INFO - 'tabpaint']}, 05:00:39 INFO - 'other-e10s': {'tests': ['a11yr', 05:00:39 INFO - 'ts_paint', 05:00:39 INFO - 'tpaint', 05:00:39 INFO - 'sessionrestore', 05:00:39 INFO - 'sessionrestore_no_auto_restore', 05:00:39 INFO - 'tabpaint']}, 05:00:39 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:00:39 INFO - 'ts_paint', 05:00:39 INFO - 'tpaint', 05:00:39 INFO - 'sessionrestore', 05:00:39 INFO - 'sessionrestore_no_auto_restore', 05:00:39 INFO - 'tabpaint']}, 05:00:39 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:00:39 INFO - 'ts_paint', 05:00:39 INFO - 'tpaint', 05:00:39 INFO - 'sessionrestore', 05:00:39 INFO - 'sessionrestore_no_auto_restore', 05:00:39 INFO - 'tabpaint']}, 05:00:39 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:00:39 INFO - 'tests': ['a11yr', 05:00:39 INFO - 'ts_paint', 05:00:39 INFO - 'tpaint', 05:00:39 INFO - 'sessionrestore', 05:00:39 INFO - 'sessionrestore_no_auto_restore', 05:00:39 INFO - 'tabpaint']}, 05:00:39 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:00:39 INFO - 'tests': ['a11yr', 05:00:39 INFO - 'ts_paint', 05:00:39 INFO - 'tpaint', 05:00:39 INFO - 'sessionrestore', 05:00:39 INFO - 'sessionrestore_no_auto_restore', 05:00:39 INFO - 'tabpaint']}, 05:00:39 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:00:39 INFO - 'tests': ['tsvgx', 05:00:39 INFO - 'tsvgr_opacity', 05:00:39 INFO - 'tart', 05:00:39 INFO - 'tscrollx', 05:00:39 INFO - 'cart', 05:00:39 INFO - 'tsvg_static']}, 05:00:39 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:00:39 INFO - 'tsvgr_opacity', 05:00:39 INFO - 'tart', 05:00:39 INFO - 'tscrollx', 05:00:39 INFO - 'cart', 05:00:39 INFO - 'tsvg_static']}, 05:00:39 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:00:39 INFO - 'talos_options': ['--disable-e10s'], 05:00:39 INFO - 'tests': ['tp5o']}, 05:00:39 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:00:39 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:00:39 INFO - 'talos_options': ['--disable-e10s', 05:00:39 INFO - '--xperf_path', 05:00:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:39 INFO - 'tests': ['tp5n']}, 05:00:39 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:00:39 INFO - 'talos_options': ['--xperf_path', 05:00:39 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:00:39 INFO - 'tests': ['tp5n']}}, 05:00:39 INFO - 'talos.zip': {'path': '', 05:00:39 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:00:39 INFO - Running post-action listener: _resource_record_post_action 05:00:39 INFO - [mozharness: 2017-01-24 13:00:39.534923Z] Finished populate-webroot step (success) 05:00:39 INFO - [mozharness: 2017-01-24 13:00:39.535033Z] Running create-virtualenv step. 05:00:39 INFO - Running pre-action listener: _resource_record_pre_action 05:00:39 INFO - Running main action method: create_virtualenv 05:00:39 INFO - Creating virtualenv /builds/slave/test/build/venv 05:00:39 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 05:00:39 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:00:39 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:00:39 INFO - Using real prefix '/tools/python27' 05:00:39 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:00:40 INFO - Installing distribute.............................................................................................................................................................................................done. 05:00:43 INFO - Installing pip.................done. 05:00:43 INFO - Return code: 0 05:00:43 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:00:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:00:43 INFO - Reading from file tmpfile_stdout 05:00:43 INFO - Output received: 05:00:43 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:00:43 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:43 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 0x107319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10731c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7724a02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070f7d30>, '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 0x10701edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070ecbe8>, '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.z4BZLI55DC/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.tnpbOvPEwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 05:00:43 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 05:00:43 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 05:00:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4BZLI55DC/Render', 05:00:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:00:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:00:43 INFO - 'HOME': '/Users/cltbld', 05:00:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:00:43 INFO - 'LOGNAME': 'cltbld', 05:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:43 INFO - 'MOZ_NO_REMOTE': '1', 05:00:43 INFO - 'NO_EM_RESTART': '1', 05:00:43 INFO - 'PAGER': '/bin/cat', 05:00:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:43 INFO - 'PWD': '/builds/slave/test', 05:00:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:00:43 INFO - 'SHELL': '/bin/bash', 05:00:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tnpbOvPEwZ/Listeners', 05:00:43 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 05:00:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:00:43 INFO - 'USER': 'cltbld', 05:00:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:00:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:43 INFO - 'XPC_FLAGS': '0x0', 05:00:43 INFO - 'XPC_SERVICE_NAME': '0', 05:00:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:00:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:43 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 05:00:43 INFO - Cleaning up... 05:00:43 INFO - Return code: 0 05:00:43 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:43 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 0x107319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10731c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7724a02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070f7d30>, '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 0x10701edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070ecbe8>, '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.z4BZLI55DC/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.tnpbOvPEwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 05:00:43 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 05:00:43 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 05:00:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4BZLI55DC/Render', 05:00:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:00:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:00:43 INFO - 'HOME': '/Users/cltbld', 05:00:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:00:43 INFO - 'LOGNAME': 'cltbld', 05:00:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:43 INFO - 'MOZ_NO_REMOTE': '1', 05:00:43 INFO - 'NO_EM_RESTART': '1', 05:00:43 INFO - 'PAGER': '/bin/cat', 05:00:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:00:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:43 INFO - 'PWD': '/builds/slave/test', 05:00:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:00:43 INFO - 'SHELL': '/bin/bash', 05:00:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tnpbOvPEwZ/Listeners', 05:00:43 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 05:00:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:00:43 INFO - 'USER': 'cltbld', 05:00:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:00:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:00:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:43 INFO - 'XPC_FLAGS': '0x0', 05:00:43 INFO - 'XPC_SERVICE_NAME': '0', 05:00:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:00:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:44 INFO - Downloading/unpacking psutil>=3.1.1 05:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:44 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:44 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:44 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:44 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:00:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:47 INFO - Installing collected packages: psutil 05:00:47 INFO - Running setup.py install for psutil 05:00:47 INFO - building 'psutil._psutil_osx' extension 05:00:47 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 05:00:48 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 05:00:48 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 05:00:48 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 05:00:48 INFO - building 'psutil._psutil_posix' extension 05:00:48 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 05:00:48 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:00:48 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:00:48 INFO - ^ 05:00:48 INFO - 1 warning generated. 05:00:48 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 05:00:48 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:00:48 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:00:48 INFO - Successfully installed psutil 05:00:48 INFO - Cleaning up... 05:00:48 INFO - Return code: 0 05:00:48 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:00:48 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')]} 05:00:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:48 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')]} 05:00:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:48 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 0x107319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10731c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7724a02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070f7d30>, '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 0x10701edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070ecbe8>, '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.z4BZLI55DC/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.tnpbOvPEwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 05:00:48 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 05:00:48 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 05:00:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4BZLI55DC/Render', 05:00:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:00:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:00:48 INFO - 'HOME': '/Users/cltbld', 05:00:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:00:48 INFO - 'LOGNAME': 'cltbld', 05:00:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:48 INFO - 'MOZ_NO_REMOTE': '1', 05:00:48 INFO - 'NO_EM_RESTART': '1', 05:00:48 INFO - 'PAGER': '/bin/cat', 05:00:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:00:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:48 INFO - 'PWD': '/builds/slave/test', 05:00:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:00:48 INFO - 'SHELL': '/bin/bash', 05:00:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tnpbOvPEwZ/Listeners', 05:00:48 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 05:00:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:00:48 INFO - 'USER': 'cltbld', 05:00:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:00:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:00:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:48 INFO - 'XPC_FLAGS': '0x0', 05:00:48 INFO - 'XPC_SERVICE_NAME': '0', 05:00:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:00:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:49 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:00:49 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 05:00:49 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 05:00:49 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 05:00:49 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 05:00:49 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 05:00:49 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 05:00:51 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:00:51 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:00:51 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:00:51 INFO - Installing collected packages: mozsystemmonitor 05:00:51 INFO - Running setup.py install for mozsystemmonitor 05:00:51 INFO - Successfully installed mozsystemmonitor 05:00:51 INFO - Cleaning up... 05:00:52 INFO - Return code: 0 05:00:52 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:00: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')]} 05:00:52 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:52 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00: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')]} 05:00:52 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:52 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:52 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 0x107319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10731c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7724a02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070f7d30>, '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 0x10701edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070ecbe8>, '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.z4BZLI55DC/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.tnpbOvPEwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 05:00:52 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 05:00:52 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 05:00:52 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4BZLI55DC/Render', 05:00:52 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:00:52 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:00:52 INFO - 'HOME': '/Users/cltbld', 05:00:52 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:00:52 INFO - 'LOGNAME': 'cltbld', 05:00:52 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:52 INFO - 'MOZ_NO_REMOTE': '1', 05:00:52 INFO - 'NO_EM_RESTART': '1', 05:00:52 INFO - 'PAGER': '/bin/cat', 05:00:52 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:00:52 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:52 INFO - 'PWD': '/builds/slave/test', 05:00:52 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:00:52 INFO - 'SHELL': '/bin/bash', 05:00:52 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tnpbOvPEwZ/Listeners', 05:00:52 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 05:00:52 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:00:52 INFO - 'USER': 'cltbld', 05:00:52 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:00:52 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:00:52 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:52 INFO - 'XPC_FLAGS': '0x0', 05:00:52 INFO - 'XPC_SERVICE_NAME': '0', 05:00:52 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:00:52 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:53 INFO - Downloading/unpacking jsonschema==2.5.1 05:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:56 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:00:56 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:56 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:56 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:00:56 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:00:56 INFO - Downloading functools32-3.2.3-2.tar.gz 05:00:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:00:56 INFO - warning: no files found matching '*.txt' 05:00:56 INFO - no previously-included directories found matching 'build' 05:00:56 INFO - no previously-included directories found matching 'dist' 05:00:56 INFO - no previously-included directories found matching '.git*' 05:00:56 INFO - Installing collected packages: jsonschema, functools32 05:00:56 INFO - Running setup.py install for functools32 05:00:56 INFO - warning: no files found matching '*.txt' 05:00:56 INFO - no previously-included directories found matching 'build' 05:00:56 INFO - no previously-included directories found matching 'dist' 05:00:56 INFO - no previously-included directories found matching '.git*' 05:00:56 INFO - Successfully installed jsonschema functools32 05:00:56 INFO - Cleaning up... 05:00:56 INFO - Return code: 0 05:00:56 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:56 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x107319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10731c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7724a02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070f7d30>, '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 0x10701edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070ecbe8>, '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.z4BZLI55DC/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.tnpbOvPEwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 05:00:56 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:00:56 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:00:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4BZLI55DC/Render', 05:00:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:00:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:00:56 INFO - 'HOME': '/Users/cltbld', 05:00:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:00:56 INFO - 'LOGNAME': 'cltbld', 05:00:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:56 INFO - 'MOZ_NO_REMOTE': '1', 05:00:56 INFO - 'NO_EM_RESTART': '1', 05:00:56 INFO - 'PAGER': '/bin/cat', 05:00:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:00:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:56 INFO - 'PWD': '/builds/slave/test', 05:00:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:00:56 INFO - 'SHELL': '/bin/bash', 05:00:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tnpbOvPEwZ/Listeners', 05:00:56 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 05:00:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:00:56 INFO - 'USER': 'cltbld', 05:00:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:00:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:00:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:56 INFO - 'XPC_FLAGS': '0x0', 05:00:56 INFO - 'XPC_SERVICE_NAME': '0', 05:00:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:57 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:00:57 INFO - Cleaning up... 05:00:57 INFO - Return code: 0 05:00:57 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:57 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:00:57 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:00:57 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:00:57 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:00:57 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 0x107319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10731c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7724a02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070f7d30>, '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 0x10701edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070ecbe8>, '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.z4BZLI55DC/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.tnpbOvPEwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 05:00:57 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 05:00:57 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 05:00:57 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4BZLI55DC/Render', 05:00:57 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:00:57 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:00:57 INFO - 'HOME': '/Users/cltbld', 05:00:57 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:00:57 INFO - 'LOGNAME': 'cltbld', 05:00:57 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:00:57 INFO - 'MOZ_NO_REMOTE': '1', 05:00:57 INFO - 'NO_EM_RESTART': '1', 05:00:57 INFO - 'PAGER': '/bin/cat', 05:00:57 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:00:57 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:00:57 INFO - 'PWD': '/builds/slave/test', 05:00:57 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:00:57 INFO - 'SHELL': '/bin/bash', 05:00:57 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tnpbOvPEwZ/Listeners', 05:00:57 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 05:00:57 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:00:57 INFO - 'USER': 'cltbld', 05:00:57 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:00:57 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:00:57 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:00:57 INFO - 'XPC_FLAGS': '0x0', 05:00:57 INFO - 'XPC_SERVICE_NAME': '0', 05:00:57 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:00:57 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:00:57 INFO - Downloading/unpacking blobuploader==1.2.4 05:00:57 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 05:00:57 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 05:00:57 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 05:00:57 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 05:00:57 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 05:00:57 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 05:01:00 INFO - Downloading blobuploader-1.2.4.tar.gz 05:01:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:01:00 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:00 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:01:00 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:00 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:00 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:00 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:00 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:01 INFO - Downloading docopt-0.6.1.tar.gz 05:01:01 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:01:01 INFO - Installing collected packages: blobuploader, requests, docopt 05:01:01 INFO - Running setup.py install for blobuploader 05:01:01 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:01:01 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:01:01 INFO - Running setup.py install for requests 05:01:02 INFO - Running setup.py install for docopt 05:01:02 INFO - Successfully installed blobuploader requests docopt 05:01:02 INFO - Cleaning up... 05:01:02 INFO - Return code: 0 05:01:02 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:02 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:02 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:02 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:02 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:02 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 0x107319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10731c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7724a02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070f7d30>, '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 0x10701edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070ecbe8>, '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.z4BZLI55DC/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.tnpbOvPEwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 05:01:02 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 05:01:02 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 05:01:02 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4BZLI55DC/Render', 05:01:02 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:01:02 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:01:02 INFO - 'HOME': '/Users/cltbld', 05:01:02 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:01:02 INFO - 'LOGNAME': 'cltbld', 05:01:02 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:02 INFO - 'MOZ_NO_REMOTE': '1', 05:01:02 INFO - 'NO_EM_RESTART': '1', 05:01:02 INFO - 'PAGER': '/bin/cat', 05:01:02 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:01:02 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:02 INFO - 'PWD': '/builds/slave/test', 05:01:02 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:01:02 INFO - 'SHELL': '/bin/bash', 05:01:02 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tnpbOvPEwZ/Listeners', 05:01:02 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 05:01:02 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:01:02 INFO - 'USER': 'cltbld', 05:01:02 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:01:02 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:01:02 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:02 INFO - 'XPC_FLAGS': '0x0', 05:01:02 INFO - 'XPC_SERVICE_NAME': '0', 05:01:02 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:01:02 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:01:02 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-0UbEJE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:01:02 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-ptdyuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:01:02 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-6YOF1z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:01:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:01:02 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-i5YfQV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:01:03 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-kZasv7-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:01:03 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-nvYuOm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:01:03 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-yoUWh4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:01:03 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-q9cm5O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:01:03 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-pBGVvW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:01:03 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-OY5TVR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:01:03 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-D5aba0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:01:03 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-BbdGOi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:01:03 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-yE7mxT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:01:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:01:03 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-TeV6rk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:04 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-Q36T_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:01:04 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-1wlqSP-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:01:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:01:04 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-9tFLZ1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:01:04 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:01:04 INFO - Running setup.py install for manifestparser 05:01:04 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:01:04 INFO - Running setup.py install for mozcrash 05:01:04 INFO - Running setup.py install for mozdebug 05:01:04 INFO - Running setup.py install for mozdevice 05:01:05 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:01:05 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:01:05 INFO - Running setup.py install for mozfile 05:01:05 INFO - Running setup.py install for mozhttpd 05:01:05 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:01:05 INFO - Running setup.py install for mozinfo 05:01:05 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:01:05 INFO - Running setup.py install for mozInstall 05:01:05 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:01:05 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:01:05 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:01:05 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:01:05 INFO - Running setup.py install for mozleak 05:01:05 INFO - Running setup.py install for mozlog 05:01:05 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:01:05 INFO - Running setup.py install for moznetwork 05:01:06 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:01:06 INFO - Running setup.py install for mozprocess 05:01:06 INFO - Running setup.py install for mozprofile 05:01:06 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:01:06 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:01:06 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:01:06 INFO - Running setup.py install for mozrunner 05:01:06 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:01:06 INFO - Running setup.py install for mozscreenshot 05:01:06 INFO - Running setup.py install for moztest 05:01:06 INFO - Running setup.py install for mozversion 05:01:06 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:01:06 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:01:06 INFO - Cleaning up... 05:01:07 INFO - Return code: 0 05:01:07 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01: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')]} 05:01:07 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:07 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01: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')]} 05:01:07 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:07 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:07 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 0x107319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10731c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7724a02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070f7d30>, '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 0x10701edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070ecbe8>, '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.z4BZLI55DC/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.tnpbOvPEwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 05:01:07 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 05:01:07 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 05:01:07 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4BZLI55DC/Render', 05:01:07 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:01:07 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:01:07 INFO - 'HOME': '/Users/cltbld', 05:01:07 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:01:07 INFO - 'LOGNAME': 'cltbld', 05:01:07 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:07 INFO - 'MOZ_NO_REMOTE': '1', 05:01:07 INFO - 'NO_EM_RESTART': '1', 05:01:07 INFO - 'PAGER': '/bin/cat', 05:01:07 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:01:07 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:07 INFO - 'PWD': '/builds/slave/test', 05:01:07 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:01:07 INFO - 'SHELL': '/bin/bash', 05:01:07 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tnpbOvPEwZ/Listeners', 05:01:07 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 05:01:07 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:01:07 INFO - 'USER': 'cltbld', 05:01:07 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:01:07 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:01:07 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:07 INFO - 'XPC_FLAGS': '0x0', 05:01:07 INFO - 'XPC_SERVICE_NAME': '0', 05:01:07 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:01:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:01:07 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-vKk8Xk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:01:07 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)) 05:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:01:07 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-jW3EaS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:01:07 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-8lR7ws-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:01:07 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)) 05:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:01:07 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-QF3i_O-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:01:07 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:01:07 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-odErxJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:01:07 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)) 05:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:01:07 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-nCmOGY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:01:07 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)) 05:01:07 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:01:07 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-PhABaJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:01:08 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)) 05:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:01:08 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-XIzeLx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:01:08 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)) 05:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:01:08 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-4Rez9g-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:01:08 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)) 05:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:01:08 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-SnYYYt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:01:08 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)) 05:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:01:08 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-27Prbh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:01:08 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)) 05:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:01:08 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-oBwiOj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:01:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:01:08 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-fu2uFh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:01:08 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)) 05:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:01:08 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-rSIQ8U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:01:08 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:08 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-x3Y6_P-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:01:08 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)) 05:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:01:08 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-V2VSBm-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:01:08 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:01:08 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:01:08 INFO - Running setup.py (path:/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/pip-hlKOO8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:01:09 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)) 05:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:01:09 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)) 05:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:01:09 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 05:01:09 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:09 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:09 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:01:09 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:01:09 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:01:11 INFO - Downloading blessings-1.6.tar.gz 05:01:11 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:01:11 INFO - Installing collected packages: blessings 05:01:11 INFO - Running setup.py install for blessings 05:01:11 INFO - Successfully installed blessings 05:01:11 INFO - Cleaning up... 05:01:12 INFO - Return code: 0 05:01:12 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:01:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:01:12 INFO - Reading from file tmpfile_stdout 05:01:12 INFO - Current package versions: 05:01:12 INFO - blessings == 1.6 05:01:12 INFO - blobuploader == 1.2.4 05:01:12 INFO - docopt == 0.6.1 05:01:12 INFO - functools32 == 3.2.3-2 05:01:12 INFO - jsonschema == 2.5.1 05:01:12 INFO - manifestparser == 1.1 05:01:12 INFO - mozInstall == 1.12 05:01:12 INFO - mozcrash == 1.0 05:01:12 INFO - mozdebug == 0.1 05:01:12 INFO - mozdevice == 0.49 05:01:12 INFO - mozfile == 1.2 05:01:12 INFO - mozhttpd == 0.7 05:01:12 INFO - mozinfo == 0.9 05:01:12 INFO - mozleak == 0.1 05:01:12 INFO - mozlog == 3.4 05:01:12 INFO - moznetwork == 0.27 05:01:12 INFO - mozprocess == 0.24 05:01:12 INFO - mozprofile == 0.28 05:01:12 INFO - mozrunner == 6.13 05:01:12 INFO - mozscreenshot == 0.1 05:01:12 INFO - mozsystemmonitor == 0.3 05:01:12 INFO - moztest == 0.8 05:01:12 INFO - mozversion == 1.4 05:01:12 INFO - psutil == 3.1.1 05:01:12 INFO - requests == 1.2.3 05:01:12 INFO - wsgiref == 0.1.2 05:01:12 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:12 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 0x107319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10731c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7724a02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070f7d30>, '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 0x10701edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070ecbe8>, '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.z4BZLI55DC/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.tnpbOvPEwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 05:01:12 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 05:01:12 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 05:01:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4BZLI55DC/Render', 05:01:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:01:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:01:12 INFO - 'HOME': '/Users/cltbld', 05:01:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:01:12 INFO - 'LOGNAME': 'cltbld', 05:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:12 INFO - 'MOZ_NO_REMOTE': '1', 05:01:12 INFO - 'NO_EM_RESTART': '1', 05:01:12 INFO - 'PAGER': '/bin/cat', 05:01:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:12 INFO - 'PWD': '/builds/slave/test', 05:01:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:01:12 INFO - 'SHELL': '/bin/bash', 05:01:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tnpbOvPEwZ/Listeners', 05:01:12 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 05:01:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:01:12 INFO - 'USER': 'cltbld', 05:01:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:01:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:12 INFO - 'XPC_FLAGS': '0x0', 05:01:12 INFO - 'XPC_SERVICE_NAME': '0', 05:01:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:12 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)) 05:01:12 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)) 05:01:12 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)) 05:01:12 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)) 05:01:12 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)) 05:01:12 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)) 05:01:12 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)) 05:01:12 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)) 05:01:12 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)) 05:01:12 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)) 05:01:12 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)) 05:01:12 INFO - Cleaning up... 05:01:12 INFO - Return code: 0 05:01:12 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:01:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:01:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:01:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x107319b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10731c768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fa7724a02e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1070f7d30>, '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 0x10701edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070ecbe8>, '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.z4BZLI55DC/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.tnpbOvPEwZ/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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 05:01:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:01:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4BZLI55DC/Render', 05:01:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:01:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:01:12 INFO - 'HOME': '/Users/cltbld', 05:01:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:01:12 INFO - 'LOGNAME': 'cltbld', 05:01:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:12 INFO - 'MOZ_NO_REMOTE': '1', 05:01:12 INFO - 'NO_EM_RESTART': '1', 05:01:12 INFO - 'PAGER': '/bin/cat', 05:01:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:01:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:12 INFO - 'PWD': '/builds/slave/test', 05:01:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:01:12 INFO - 'SHELL': '/bin/bash', 05:01:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tnpbOvPEwZ/Listeners', 05:01:12 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 05:01:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:01:12 INFO - 'USER': 'cltbld', 05:01:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:01:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:01:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:12 INFO - 'XPC_FLAGS': '0x0', 05:01:12 INFO - 'XPC_SERVICE_NAME': '0', 05:01:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:01:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:01:12 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:01:12 INFO - Cleaning up... 05:01:12 INFO - Return code: 0 05:01:12 INFO - Running post-action listener: _resource_record_post_action 05:01:12 INFO - Running post-action listener: _start_resource_monitoring 05:01:12 INFO - Starting resource monitoring. 05:01:12 INFO - [mozharness: 2017-01-24 13:01:12.905404Z] Finished create-virtualenv step (success) 05:01:12 INFO - [mozharness: 2017-01-24 13:01:12.906382Z] Running install step. 05:01:12 INFO - Running pre-action listener: _resource_record_pre_action 05:01:12 INFO - Running main action method: install 05:01:12 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:01:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:01:13 INFO - Reading from file tmpfile_stdout 05:01:13 INFO - Detecting whether we're running mozinstall >=1.0... 05:01:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:01:13 INFO - Reading from file tmpfile_stdout 05:01:13 INFO - Output received: 05:01:13 INFO - Usage: mozinstall [options] installer 05:01:13 INFO - Options: 05:01:13 INFO - -h, --help show this help message and exit 05:01:13 INFO - -d DEST, --destination=DEST 05:01:13 INFO - Directory to install application into. [default: 05:01:13 INFO - "/builds/slave/test"] 05:01:13 INFO - --app=APP Application being installed. [default: firefox] 05:01:13 INFO - mkdir: /builds/slave/test/build/application 05:01:13 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:01:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-53.0a2.en-US.mac.dmg --destination /builds/slave/test/build/application 05:01:32 INFO - Reading from file tmpfile_stdout 05:01:32 INFO - Output received: 05:01:32 INFO - /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox 05:01:32 INFO - Running post-action listener: _resource_record_post_action 05:01:32 INFO - [mozharness: 2017-01-24 13:01:32.986373Z] Finished install step (success) 05:01:32 INFO - [mozharness: 2017-01-24 13:01:32.986533Z] Running run-tests step. 05:01:32 INFO - Running pre-action listener: _resource_record_pre_action 05:01:32 INFO - Running main action method: run_tests 05:01:32 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:01:32 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:01:32 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:01:33 INFO - 2017-01-24 05:01:33.000 screenresolution[1632:7359] starting screenresolution argv=screenresolution get 05:01:33 INFO - 2017-01-24 05:01:33.003 screenresolution[1632:7359] Display 0: 1600x1200x32@60 05:01:33 INFO - 2017-01-24 05:01:33.009 screenresolution[1633:7362] starting screenresolution argv=screenresolution list 05:01:33 INFO - Available Modes on Display 0 05:01:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:01:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:01:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:01:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:01:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:01:33 INFO - Intel Iris: 05:01:33 INFO - Chipset Model: Intel Iris 05:01:33 INFO - Type: GPU 05:01:33 INFO - Bus: Built-In 05:01:33 INFO - VRAM (Dynamic, Max): 1536 MB 05:01:33 INFO - Vendor: Intel (0x8086) 05:01:33 INFO - Device ID: 0x0a2e 05:01:33 INFO - Revision ID: 0x0009 05:01:33 INFO - Displays: 05:01:33 INFO - Display: 05:01:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:01:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:01:33 INFO - Display Serial Number: 1600x1200 60 05:01:33 INFO - Main Display: Yes 05:01:33 INFO - Mirror: Off 05:01:33 INFO - Online: Yes 05:01:33 INFO - Rotation: Supported 05:01:33 INFO - Return code: 0 05:01:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:01:33 INFO - Python 2.7.3 05:01:33 INFO - Return code: 0 05:01:33 INFO - grabbing minidump binary from tooltool 05:01:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:01:33 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 0x1070f7d30>, '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 0x10701edb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1070ecbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:01:33 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 05:01:33 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 05:01:33 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 05:01:33 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:01:33 INFO - Return code: 0 05:01:33 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:01:33 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:01:33 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:01:33 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:01:33 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:01:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0327', '--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 05:01:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Mozilla-Aurora --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0327 --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 05:01:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.z4BZLI55DC/Render', 05:01:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:01:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:01:33 INFO - 'HOME': '/Users/cltbld', 05:01:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:01:33 INFO - 'LOGNAME': 'cltbld', 05:01:33 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:01:33 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:01:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:01:33 INFO - 'MOZ_NO_REMOTE': '1', 05:01:33 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:01:33 INFO - 'NO_EM_RESTART': '1', 05:01:33 INFO - 'PAGER': '/bin/cat', 05:01:33 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:01:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:01:33 INFO - 'PWD': '/builds/slave/test', 05:01:33 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:01:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:01:33 INFO - 'SHELL': '/bin/bash', 05:01:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.tnpbOvPEwZ/Listeners', 05:01:33 INFO - 'TMPDIR': '/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/', 05:01:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:01:33 INFO - 'USER': 'cltbld', 05:01:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:01:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:01:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:01:33 INFO - 'XPC_FLAGS': '0x0', 05:01:33 INFO - 'XPC_SERVICE_NAME': '0', 05:01:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:01:33 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Mozilla-Aurora', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0327', '--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 05:01:33 INFO - mozversion application_buildid: 20170124032343 05:01:33 INFO - mozversion application_changeset: 5d14c6efd4bab1bb849db13238bf95a3a06b1d9e 05:01:33 INFO - mozversion application_display_name: FirefoxDeveloperEdition 05:01:33 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:01:33 INFO - mozversion application_name: Firefox 05:01:33 INFO - mozversion application_remotingname: firefox-dev 05:01:33 INFO - mozversion application_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:01:33 INFO - mozversion application_vendor: Mozilla 05:01:33 INFO - mozversion application_version: 53.0a2 05:01:33 INFO - mozversion platform_buildid: 20170124032343 05:01:33 INFO - mozversion platform_changeset: 5d14c6efd4bab1bb849db13238bf95a3a06b1d9e 05:01:33 INFO - mozversion platform_repository: https://hg.mozilla.org/releases/mozilla-aurora 05:01:33 INFO - mozversion platform_version: 53.0a2 05:01:33 INFO - using testdate: 1485262893 05:01:33 INFO - actual date: 1485262893 05:01:33 INFO - starting webserver on 'localhost:49240' 05:01:33 INFO - SUITE-START | Running 2 tests 05:01:33 INFO - TEST-START | dromaeo_css 05:01:33 INFO - operating with platform_type : mac_ 05:01:33 INFO - Initialising browser for dromaeo_css test... 05:01:33 INFO - TEST-INFO | started process 1643 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpPxOYbz/profile http://localhost:49240/getInfo.html) 05:01:36 INFO - PROCESS | 1643 | __metrics Screen width/height:1600/1200 05:01:36 INFO - PROCESS | 1643 | colorDepth:24 05:01:36 INFO - PROCESS | 1643 | Browser inner width/height: 1024/689 05:01:36 INFO - PROCESS | 1643 | __metrics 05:01:36 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 05:01:36 INFO - PROCESS | 1643 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:01:36 INFO - PROCESS | 1643 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:01:36 INFO - TEST-INFO | 1643: exit 0 05:01:36 INFO - Browser initialized. 05:01:36 INFO - Running cycle 1/1 for dromaeo_css test... 05:01:36 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpPxOYbz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:01:48 INFO - PROCESS | 1645 | RSS: Main: 212885504 05:01:48 INFO - PROCESS | 1645 | 05:04:51 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49240/tests/dromaeo/cssquery-ext.html) 05:04:53 INFO - PROCESS | 1645 | RSS: Main: 328773632 05:04:53 INFO - PROCESS | 1645 | 05:06:38 INFO - PROCESS | 1645 | ************************* 05:06:38 INFO - PROCESS | 1645 | A coding exception was thrown and uncaught in a Task. 05:06:38 INFO - PROCESS | 1645 | 05:06:38 ERROR - PROCESS | 1645 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:06:38 INFO - PROCESS | 1645 | Full stack: 05:06:38 INFO - PROCESS | 1645 | ************************* 05:07:56 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-ext.html (next: http://localhost:49240/tests/dromaeo/cssquery-jquery.html) 05:07:57 INFO - PROCESS | 1645 | RSS: Main: 349216768 05:07:57 INFO - PROCESS | 1645 | 05:10:59 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49240/tests/dromaeo/cssquery-mootools.html) 05:11:00 INFO - PROCESS | 1645 | RSS: Main: 333320192 05:11:00 INFO - PROCESS | 1645 | 05:14:02 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49240/tests/dromaeo/cssquery-prototype.html) 05:14:03 INFO - PROCESS | 1645 | RSS: Main: 326262784 05:14:03 INFO - PROCESS | 1645 | 05:17:06 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49240/tests/dromaeo/cssquery-yui.html) 05:17:07 INFO - PROCESS | 1645 | RSS: Main: 315703296 05:17:07 INFO - PROCESS | 1645 | 05:20:09 INFO - PROCESS | 1645 | Cycle 1(1): loaded http://localhost:49240/tests/dromaeo/cssquery-yui.html (next: http://localhost:49240/tests/dromaeo/cssquery-dojo.html) 05:20:10 INFO - PROCESS | 1645 | RSS: Main: 590573568 05:20:10 INFO - PROCESS | 1645 | 05:20:10 INFO - PROCESS | 1645 | __start_tp_report 05:20:10 INFO - PROCESS | 1645 | _x_x_mozilla_page_load 05:20:10 INFO - PROCESS | 1645 | _x_x_mozilla_page_load_details 05:20:10 INFO - PROCESS | 1645 | |i|pagename|runs| 05:20:10 INFO - PROCESS | 1645 | |0;dojo.html;2711.566149416093;3295.719863811576;3305.6033276006883;3335.399628066947;3357.6474470180647;5719.4566516181;5737.770489180433;5771.826845194641;5809.564282678795;5815.970920145399;5741.712914354286;5799.18811366409;5813.941860581393;5829.387914268994;5851.239338885939;5234.345706786661;5273.499017593323;5276.841694749163;5295.496927791873;5329.920051199235;5178.0161769263905;5187.948120518784;5190.195519694454;5359.892802143955;5407.83776486706;5283.8150664726745;5285.814996475124;5308.654937429074;5319.946800532003;5321.707306098163;5246.475352464761;5249.895002099975;5251.10731175701;5289.338832645919;5343.973280133613;5195.454477279869;5238.554722848562;5272.051030814452;5286.471352864683;5319.946800531984;5887.911681324784;5893.44012318829;5932.406759324076;5975.163477113164;5978.730957106941;5166.715830629314;6142.099766648166;6170.629762214281;6210.72051757672;6216.129741836146;6279.340669229757;6323.525735569805;6351.951927931886;6361.395667411589;6372.98032314832;5898.41015898411;5955.523558115384;5966.880662386728;5968.358701357161;6006.978813601698;6310.211223597051;6323.146375239284;6354.3963323484195;6360.268569114519;6377.075324077982;6155.10750941111;6159.045347971071;6169.629822210682;6171.907421388682;6172.660503672341;6261.655608941552;6286.402791734778;6293.527985401113;6385.553011289165;6395.6482393468805;6289.591176573508;6333.240011198685;6341.985282354801;6347.365263473708;6362.331955144736;4499.52754960731;6216.098665693449;6349.984002559569;6352.904706429407;6387.840303992437;4943.036107958914;4964.081644895634;4990.80036798524;4995.275685025724;4995.475475075137;4474.32885067236;4488.708233964782;4489.573490518395;4512.819487220474;4523.389342438729;5756.992526307879;5781.248437703071;5796.478316951495;5809.186713860063;5812.970935145382;6185.381461853779;6278.686065696788;6285.277193122758;6319.747210111544;6321.431071203522;5639.774409023593;5693.202951586781;5699.173619825102;5746.396628353963;5830.62100963436;5476.479734425223;5509;5514.558835293167;5527.50252477279;5543.334799824047;6386.329435409215;6411.455026322628;6431.2604050533855;6435.388638079375;6452.22573291208;6200.038993955944;6269.467095296951;6278.874422511615;6283.622982621057;6322.209723784527;6331;6392.552521323462;6403.775867844603;6414.871702565829;6453.709583068867;6291.811245662638;6298.496120310272;6302.1492098566105;6306.905396418965;6328;6130.979101201984;6232.563720539519;6320.083587879823;6329.461995730415;6346.650934198478;5149.588032957429;6065.8180254592435;6108.938910611015;6214.720337584729;6221.222347206599;6167.982282923447;6191.226096737908;6197.752089916353;6204.317525072148;6206.224221972254;5007.549320561167;5862.208601838868;5899.616524925866;5995.550333725076;6071;5728.54171666274;6071.7571297147615;6124.197855633957;6140.692965351804;6227.159333490102;6054.636721796706;6063.363346848694;6063.938810708197;6070.271567411939;6076.483498902466 05:20:10 INFO - PROCESS | 1645 | |1;ext.html;458.6995517935751;498.3098408703945;502.4975024975025;502.85417229003593;506.37715609799943;28019.719802801967;33390.16524586886;33435.49846752294;33455.16362090943;33469.66530334699;42597.935051623645;44659;44733.7763311183;46874.76562617191;46974;9439.575219115157;9621.567029483655;9639.325247232697;9650.276229282797;9663.323567350288;8577.442466239705;9504.192143667797;9628.47043412612;9639.951800241024;9651.118031983766;8640.913590864106;11399.886001139965;11583.594574189863;11619.941900290487;11835.467403966843;11480.25378350413;11534.423278836066;11616.070714342832;11644.883551164465;11695.473703683312;8508.78728031798;11532.59635912739;11534.769304613861;11596.434481345079;11620.825687614693;31664.366712665847;40805.38791918124;41455.58544414547;41543.37684934728;43479.78260108711;3491.336646037245;3952.249072676211;4034.899127521806;4047.2917239483268;4250.192463431938;26591.335216619547;29158.41683166325;30490.54264186039;30512.84743576268;30765;3158;3179.761517886168;3254.6094468663673;3290.6051273847293;3293.127321259868;509156.9999999963;510739;513153.4342328302;514050;514997;58959.41040589625;59140.7042964791;59240.111398329056;59323.406765932654;59354;61807.690961545806;61859;61994.210260538384;62052.069218961755;62113.06830397547;15778.13220272896;16211.27049282785;16227;16280;16282.592935176715;12120.090993175547;12443;12582.622521324374;12680.429380677891;12684;15640.4525841595;15994;18013.099345032697;18275.54311142232;18290.085495725427;5462.863428414242;6787.5588086774205;7889.132195458495;7911.666058512753;8056.83886322282;877.1579283887539;892.3040028777564;903.6159632156307;905.1355955062899;925.842606756853;30038.279890628884;30807.845960770053;30869.845650771604;30900.381992360028;31482.212944676565;1077.3912739302268;1077.7251800790748;1081.3349789879326;1096.1395304685784;1237.5049980007889;15537.06777593348;15944.123073230852;16037.358505659642;16127.681633303931;16192.919035404748;654214;656909.7154514197;658334;659873;660063;62811.74376512444;63005.73988520296;63030.68484657639;63391.36608633947;63462.048069279;1442.5528086293282;1448.9120872099563;1460.1239256446047;1479.88900832438;1482.9629259268388;28955.855220724603;29879.850600747726;30598.541021884244;30653.751826987744;30696.84651576728;46867.062658747316;47060;47121.52878471308;47160.292595611776;47190.05619887652;536759.3162034322;540276;540844;541761;541894;22628.208012719475;26458;26772.330691732863;26995.190144295702;27129;39335;42823.7858810704;48652;49027.50972490372;52361;38520;38914;39264;40650.390244146955;41052.384214237405;40442.79778601088;40564;40714.9821254471;40915.38626920539;42113.36829947492;38395.6160438392;38754;39060;39156;39264.6073539261;34603.826980864935;34716.47925281072;35409.468857967666;35504.46743298904;35705.46441803427;22657.980390882778;25847.224583262534;25895.482090358466;26055.478890422466;26430.471390572464 05:20:10 INFO - PROCESS | 1645 | |2;jquery.html;352.86943830782604;389.08370786797093;401.5021373496861;404.2117870153202;426.38813302910324;14252.358643861025;20323.390298291055;21052.473688157803;21608.459788505275;21649;16481.92338924622;18478.260869565234;21216.36350909475;21484.892575537102;21948.561028779415;5254.868628284305;5753.309602847664;6106.542009349317;6107.297660769002;6108.267007959051;5869.060950247961;5991.850203744898;5992.49063829575;6071.150038994544;6103.45068943795;6048.39516048396;6050.546209034318;6051.878962420749;6057.848553786146;6072.696365181745;5787.131930210481;5946.821595352168;6019.367966363513;6029.427204415618;6031.849203769897;5223.869403264911;5256.448072952361;5258.55302299305;5263.4999675031195;5270.077736396153;25035.37411564707;26122.085726999652;26179;26321.07876224323;26410.73589264102;2325.2094287942014;2788.4980703473366;2829.2643912582876;2855.6287682601337;2861.184562399706;14850.554483365517;14973.1016139032;15009.324580393799;15280.235988200546;15825.841741582552;1684.6209602839385;1790.1675720789895;1810.63787242552;1814.8475717919216;1880.341880341883;130736.99999999905;134567.81559074813;138255.6174438253;138841;140191;9130.49782261982;11044.134552906418;11338.773224535627;11373.270415100316;11467.305183281922;11838.585649502225;14204.71590568183;14221.715565688628;14230.644233894029;14235.28823558818;7797.649105790253;8183;8190.672373105009;8463.534505602127;8591.226789588967;8775.692850750193;8802.955985220033;8875.511846848356;8878.467291962503;9056.773580660536;6934.098567186234;7026.859462810715;7033.1560212773775;7070.434365250768;7136;1615.4668959243422;1855.9628807423776;1886.3869242496244;1894.422201228611;1898.1648074847024;889.1330952321564;918.5315489100607;929.419113054341;938.8732521109563;944.9102335278137;17964.531616917437;20631;21986.45033874166;22276.331710048402;22344;950.6405839649368;959.4531117263233;984.1683777208248;984.3306551544875;988.604558176735;11361.318320900773;11503.942480287546;11711;11755.764884702428;11811.232269902428;779098;781051;783278;802458;802703;105397.73011349402;133342;140419.29790351188;140596;142534;1014.6955913226003;1033.493588141805;1044.4829809244472;1046.7697106636529;1047.6699839550517;13997;19028;19431.61136777285;19458.31895883637;19545.022748862786;54616.81532738646;56003.43996559982;56390.43609563852;57075.42924570867;59273.70363148156;78999;80940.59529702314;81953.59023204846;82864;83248.16751832646;6624.503162262753;6686.398224159849;7973.681052757825;8198.590070496331;8242.010958684756;7516;11848.526058957545;12271.75456490883;12797.872021279669;13344.733105338033;11240.606578769704;11439.485223164811;11720.589779357682;11845.466953987263;11904.702382440162;10904.182186336215;11145;11390.715232118931;11518.07855371585;11613.941930290295;8860.689875854314;11413.144014198802;11665.59170429031;11961.940190298992;12022.158448908493;7402.888956665762;7473.738419155304;7992.84014319722;8211.58942052907;8308.086110527958;10950.780984380428;11452.541898324307;11470.254433461798;11573.942130289632;11663.59177428786 05:20:10 INFO - PROCESS | 1645 | |3;mootools.html;1287.7424515096982;1425.1662777275294;1443.4442739545273;1447.7321695486337;1447.7900704397855;8124.918750812498;8506.319494440446;8517.701880434186;8531.146885311473;8540.658373665061;7555.282248186427;7767.417443691717;8110.959445202766;8328.417010809246;8382.538960357178;2331.4287999440076;2338.286822519135;2341.309313752439;2387.916422925198;2389.916352927648;2366.3610825077217;2385.7494963028894;2399.6520504526834;2404;2407.2898494943947;2004.9498762530907;2078.5738923520717;2082.011044753737;2150.6451435513122;2345.589521833681;2328.0338659456306;2334.2063698342645;2335.2293743064834;2335.7313908900524;2337.0418128567376;2301.401635574746;2339.5554844579474;2374.1453076892303;2376.988115059431;2381.357033600935;8453.239208471266;8488.236058754741;8495.447795893248;8497.447665901696;8507.702230421968;5097.668651537638;5256.316678831766;5265.052290587692;5269.710165940872;5273.209018647195;3015.6079709637825;3366.898993030213;3516.8944931651836;3581.1405262737017;3591.191981804099;1128.05807151029;1183.8401815754935;1194.832723418722;1217.2148963918223;1263.298869127643;10695.144388448984;10792;10815.83776243357;10866.61966831157;10875.78248435027;4454.086912182995;4649.418822647169;4677.017826256524;4746.07451546952;4758.119747846659;9555;9555.092266234697;9564.521773911416;9570.47362395075;9571.856422153673;5233.398159211663;5243.580513558906;5247.134222853187;5252.894942101137;5263.973680131651;4286.099919017041;4423.203823311835;4614.792334344963;4711.646626503026;4727.101850648366;3831.540215174197;3861.3242682530445;3917.9608203918165;3950.6246906543834;3963.326234540135;1079.4063265204106;1268.055298802398;1271.3007845684836;1283.4673610451744;1285.6078895936641;909.4906852162678;910.8132832769398;918.779492921694;926.9073092690812;950.2540505703129;4797.472278049412;5556.166575013699;5758.596898217168;5804.9419505805245;5849.619774714715;993.1310103659298;1002.6791426743372;1005.597760895633;1011.1203253169789;1042.3485321673954;3723.6408710820897;3878.5151856017997;3954.6638535724787;3965.940510892339;4027.778472184058;9828.950855245821;10044.397336159855;10082.344647597884;10111.64609238673;10182.541785619665;9494.620215191315;9915.256355773347;9935.850962235572;10016.098551130288;10029.79940401188;7757.883631745528;7929.762107136795;7930;7933.206679332136;7966.442349035628;5718.742656580381;5764.452377024176;5774.82675519735;5840.707964601668;6040.124181993674;9333.626654933727;9389.48357840298;9403.764905877408;9414.293927955294;9415.011423800675;8995.595198215966;9366.016568260235;9371.109744574254;9464.242860571276;9475.905240947503;6627.933720662924;6841.589504629539;6854.897176542456;7162.462815288978;7312.634368281671;7747.6513556891205;7823.217678232359;7994.960655114798;8096.595170241582;8098.676052957816;7075.50471467013;7081.398081163159;7180.281971802778;7209.423246140401;7291.34377905991;7011.4390848733;7103.218645949045;7134.678939447841;7262.31008054234;7271.091113610799;5447.182922561489;6408.743650253938;6411.679416029273;6481.675916204265;6489.9026514603265;4995.300657907823;5028.84913452597;5042.84871453857;5056.84829455117;5080.060188865072;4879.975600121977;4895.534924182197;5062.898742025212;5163.948360516347;5183.766730497061 05:20:10 INFO - PROCESS | 1645 | |4;prototype.html;310.6598274888996;363.75414206343265;366.5070480204125;373.704773229149;374.305662995144;4780;4965.063625186176;4966.875828104299;5401.945980540203;5403.9197657335335;4579.839705610304;5051.419086805018;5162.277281180638;5327.600429967749;5359.196120581914;3621.8551257949653;3741.7754934703867;3962.385830196317;4058.6347228749405;4168.729032612886;3471.8542880849386;3938.6652134568594;4039.899002524931;4152.460180176573;4180.519240287375;3478.2521757822065;3500;4010.6590939770153;4175.331946888498;4180.707350485467;3465.203003309253;3980.900477488057;4103.466549348565;4174.019105510202;4217.746935183899;3129.5305704144334;3259.0060031690564;3684.613115622875;3687.3362794696945;3722.497462842509;5216.347956505437;5226.947730522722;5235.240890070919;5307.575393968474;5336.119540275849;4051.837926482967;4673.112108699336;4824.789227634146;4909.7790599423115;4913.017396520674;4773.064565292355;5723.885522289531;5729.512991395736;5741.1388291756575;5746.971265143689;4107.856225032109;4110.691698122623;4112.3420252759415;4115.382692596135;4144.41978123063;4715.575598196145;4784.665073444826;5282.524572788468;6015.608985415934;6043.7280322385595;3524.8674551896247;3839.7328881469048;4029;4235.53409124996;4241.745495270294;4112.362583799516;4282.892927676833;4306.504751953503;4311.353297005474;4339.717918335298;4723.834665786681;4848.8787780305065;4872.512748725099;4887.780049897763;4917.213245880642;4825.372701548777;5047.2429135629945;5207;5494.917576236359;5754.597178197486;1297;1384.1487485196733;1385.2035079829138;1398.2449477282153;1402.6423262068108;904.4889637354873;927.3879239701764;969.4328817641617;981.5779214937503;994.1152374386802;4747.8575642730775;4950.480199578992;4991.376077990251;5007.4241462231585;5031.949680503149;4808.591269742041;4994.450610432922;5470.64440811354;5536.501714845684;5587.842868779208;4716.834910778106;4752.477227504972;4961.975190124026;5005.4483110235215;5019.874503137451;2661.3765602982166;2885.898993535216;2918.693537178608;2924.707529247101;2932.985335073311;5183.688978661217;5219.373675159005;5721.5136713379825;5746.569007324468;5751.712414379264;4768.883431694833;4874.975625121851;5288.848254120497;5681.062624666966;5746;4880.780364883518;5254.211868219798;5269.257668098742;5699.458551437607;5747.4252574742195;4775.450823155382;5172.250023746611;5540.390557038803;5546.833594992157;5559.360673522435;5088.618353623419;5186;5209.348831396075;5229.731417863835;5339.997500937148;5126.56424203932;5675.545956323567;5767.500449882977;5917.437843404869;5982.49148822355;3864.42033694948;3894.9221015578964;3905.3165696002516;3907.199024199975;3911.1395492991496;5775.556110972257;5838.474537291664;5840.503557197686;5858.443447872445;5860.912086318794;4629.375034370317;5287.889543195972;5363.597730170331;5421.810236641699;5654.717264136694;5025;5118.360204974379;5649.152627105967;5651.463111004448;5653.095504719389;5119.539241468286;5325.307709997831;5508.862278443071;5532.91700624499;5556.444195625231;5583.302087239095;5635.323761148688;5642.489092353863;5660.7169641518585;5664.320281566238;4638.8144474222;5051.751970373149;5506.284183056177;5527.474889885454;5540.390557038803 05:20:10 INFO - PROCESS | 1645 | |5;yui.html;723.8552289542093;725.9891101633473;785.2696991797626;804.537391000175;837.2924878477686;14889.851101488983;15888.205589720497;15917.204139793022;15920.522384328475;15952.840471595266;14441.783373249384;14636.268186590654;14914.254287285647;14922;14991.775123373158;850.9829803403959;886.5079880666227;906.7370462565848;909;909.231699214163;890.9732708018737;912.6988093928987;914.2092090341873;914.2411798207505;916.9679061232858;953.4184147669915;956.1251454918776;956.4118067388541;958.6692591056075;959.357230655459;949.7008442340641;950.752804270891;953.4660590069583;954.1317401164976;956.3257903178243;609.3053918532876;644.310587671192;715.7029832619456;716.0512321174465;718.4503854551273;13641.522546710918;13955.58133256004;14036.649083772885;14142.575722728334;14165.645858853508;12002.63992080239;12112;12195.207311524722;12282.508699652004;12284.637517518682;10651.946740266327;10688.09151222147;10959.397233152173;10978.780424391547;11104.777904441948;3363.7722231385615;3505.1587618971516;3667.2848794485085;3770.7926064066464;3801.600831912637;96693.51653241689;100989;102268;102284.48857755738;102705.4864725679;9118.179363857285;9170.44977301364;9200.631974720936;9234.353595248402;9265.2124569411;16577.585560361087;19883.502912427306;20039.29862454807;20169.798302017087;20218;7581.355584775356;7860.135385107634;7889.2110788920645;8067.3142782864115;8082.9191708083345;4282.207791558571;4293.055527783882;4438.134563760101;4448.755318457516;4507.549245075466;3607.7113830893463;3666.6333366663653;3677.5219221501034;3744.970133213388;3754.662080412776;661.1438187547042;663.6117871045492;664.833791552112;671.4561205423524;672.6098862659743;623.5884316351187;668.2882729892649;681.8125015620744;696.2445746365149;697.4106879686657;9883.308168428284;10469.020500002422;10561.894381056245;10564.947175264075;10891.237613366988;687.2303020616941;715.1632589869864;715.3275920634587;721.4625104297332;724.840535082281;4207.516135644379;4641.187792136363;5051.87370315745;5075.086484432837;5078.390593128848;98386;98843;99432.5028374868;99520.50239748899;101160;55683;58892.52768680817;60619.09071363933;68261.65869170622;89445.55277223572;59340.70329648324;75239.4952100955;76684;77297.6135119332;78557;10737.677869663923;10946.39794811293;11177.72055698614;11202.551897923991;11212.215144939775;41673.91293545877;44922.550774491836;46442.76778616085;48420.757896211704;49758.75120624374;58373;64700.05899823013;65484.345156547824;68966.31033689599;69110.65444672745;11295.491702873225;12551.748965020832;13013.414396352377;13043.934780326037;13077.149985250928;12063.879361206276;12151.331676757509;12175.391230438265;12535.874641253471;13034.217946923214;13206.735865282833;13870;14142.858571414154;14215.857841421453;14981.101133932;12500.937495312466;13800.309984500936;14408.495702650356;14517.201553914636;14707.411703532167;13170.407331669907;13847.108771755753;13959.678022279426;14095.577132686036;14156.575302740934;10519.368837869752;11100.222984391015;11627.186096973131;11777.52889884395;11780.941095294469;7246;10191.694249172537;10311.432871192157;11068.723281918017;11133.332000080021 05:20:10 INFO - PROCESS | 1645 | __end_tp_report 05:20:10 INFO - PROCESS | 1645 | __start_cc_report 05:20:10 INFO - PROCESS | 1645 | _x_x_mozilla_cycle_collect,1677 05:20:10 INFO - PROCESS | 1645 | __end_cc_report 05:20:10 INFO - PROCESS | 1645 | __startTimestamp1485264010089__endTimestamp 05:20:10 INFO - PROCESS | 1645 | 05:20:10 INFO - PROCESS | 1645 | ------- Summary: start ------- 05:20:10 INFO - PROCESS | 1645 | Number of tests: 6 05:20:10 INFO - PROCESS | 1645 | 05:20:10 INFO - PROCESS | 1645 | [#0] dojo.html Cycles:165 Average:5787.90 Median:6006.98 stddev:678.55 (11.3%) stddev-sans-first:636.27 05:20:10 INFO - PROCESS | 1645 | Values: 2711.6 3295.7 3305.6 3335.4 3357.6 5719.5 5737.8 5771.8 5809.6 5816.0 5741.7 5799.2 5813.9 5829.4 5851.2 5234.3 5273.5 5276.8 5295.5 5329.9 5178.0 5187.9 5190.2 5359.9 5407.8 5283.8 5285.8 5308.7 5319.9 5321.7 5246.5 5249.9 5251.1 5289.3 5344.0 5195.5 5238.6 5272.1 5286.5 5319.9 5887.9 5893.4 5932.4 5975.2 5978.7 5166.7 6142.1 6170.6 6210.7 6216.1 6279.3 6323.5 6352.0 6361.4 6373.0 5898.4 5955.5 5966.9 5968.4 6007.0 6310.2 6323.1 6354.4 6360.3 6377.1 6155.1 6159.0 6169.6 6171.9 6172.7 6261.7 6286.4 6293.5 6385.6 6395.6 6289.6 6333.2 6342.0 6347.4 6362.3 4499.5 6216.1 6350.0 6352.9 6387.8 4943.0 4964.1 4990.8 4995.3 4995.5 4474.3 4488.7 4489.6 4512.8 4523.4 5757.0 5781.2 5796.5 5809.2 5813.0 6185.4 6278.7 6285.3 6319.7 6321.4 5639.8 5693.2 5699.2 5746.4 5830.6 5476.5 5509.0 5514.6 5527.5 5543.3 6386.3 6411.5 6431.3 6435.4 6452.2 6200.0 6269.5 6278.9 6283.6 6322.2 6331.0 6392.6 6403.8 6414.9 6453.7 6291.8 6298.5 6302.1 6306.9 6328.0 6131.0 6232.6 6320.1 6329.5 6346.7 5149.6 6065.8 6108.9 6214.7 6221.2 6168.0 6191.2 6197.8 6204.3 6206.2 5007.5 5862.2 5899.6 5995.6 6071.0 5728.5 6071.8 6124.2 6140.7 6227.2 6054.6 6063.4 6063.9 6070.3 6076.5 05:20:10 INFO - PROCESS | 1645 | 05:20:10 INFO - PROCESS | 1645 | [#1] ext.html Cycles:180 Average:70421.32 Median:39210.00 stddev:153259.96 (390.9%) stddev-sans-first:153599.87 05:20:10 INFO - PROCESS | 1645 | Values: 458.7 498.3 502.5 502.9 506.4 28019.7 33390.2 33435.5 33455.2 33469.7 42597.9 44659.0 44733.8 46874.8 46974.0 9439.6 9621.6 9639.3 9650.3 9663.3 8577.4 9504.2 9628.5 9640.0 9651.1 8640.9 11399.9 11583.6 11619.9 11835.5 11480.3 11534.4 11616.1 11644.9 11695.5 8508.8 11532.6 11534.8 11596.4 11620.8 31664.4 40805.4 41455.6 41543.4 43479.8 3491.3 3952.2 4034.9 4047.3 4250.2 26591.3 29158.4 30490.5 30512.8 30765.0 3158.0 3179.8 3254.6 3290.6 3293.1 509157.0 510739.0 513153.4 514050.0 514997.0 58959.4 59140.7 59240.1 59323.4 59354.0 61807.7 61859.0 61994.2 62052.1 62113.1 15778.1 16211.3 16227.0 16280.0 16282.6 12120.1 12443.0 12582.6 12680.4 12684.0 15640.5 15994.0 18013.1 18275.5 18290.1 5462.9 6787.6 7889.1 7911.7 8056.8 877.2 892.3 903.6 905.1 925.8 30038.3 30807.8 30869.8 30900.4 31482.2 1077.4 1077.7 1081.3 1096.1 1237.5 15537.1 15944.1 16037.4 16127.7 16192.9 654214.0 656909.7 658334.0 659873.0 660063.0 62811.7 63005.7 63030.7 63391.4 63462.0 1442.6 1448.9 1460.1 1479.9 1483.0 28955.9 29879.9 30598.5 30653.8 30696.8 46867.1 47060.0 47121.5 47160.3 47190.1 536759.3 540276.0 540844.0 541761.0 541894.0 22628.2 26458.0 26772.3 26995.2 27129.0 39335.0 42823.8 48652.0 49027.5 52361.0 38520.0 38914.0 39264.0 40650.4 41052.4 40442.8 40564.0 40715.0 40915.4 42113.4 38395.6 38754.0 39060.0 39156.0 39264.6 34603.8 34716.5 35409.5 35504.5 35705.5 22658.0 25847.2 25895.5 26055.5 26430.5 05:20:10 INFO - PROCESS | 1645 | 05:20:10 INFO - PROCESS | 1645 | [#2] jquery.html Cycles:180 Average:41360.34 Median:26250.04 stddev:130805.68 (498.3%) stddev-sans-first:131136.38 05:20:10 INFO - PROCESS | 1645 | Values: 352.9 389.1 401.5 404.2 426.4 14252.4 20323.4 21052.5 21608.5 21649.0 16481.9 18478.3 21216.4 21484.9 21948.6 5254.9 5753.3 6106.5 6107.3 6108.3 5869.1 5991.9 5992.5 6071.2 6103.5 6048.4 6050.5 6051.9 6057.8 6072.7 5787.1 5946.8 6019.4 6029.4 6031.8 5223.9 5256.4 5258.6 5263.5 5270.1 25035.4 26122.1 26179.0 26321.1 26410.7 2325.2 2788.5 2829.3 2855.6 2861.2 14850.6 14973.1 15009.3 15280.2 15825.8 1684.6 1790.2 1810.6 1814.8 1880.3 130737.0 134567.8 138255.6 138841.0 140191.0 9130.5 11044.1 11338.8 11373.3 11467.3 11838.6 14204.7 14221.7 14230.6 14235.3 7797.6 8183.0 8190.7 8463.5 8591.2 8775.7 8803.0 8875.5 8878.5 9056.8 6934.1 7026.9 7033.2 7070.4 7136.0 1615.5 1856.0 1886.4 1894.4 1898.2 889.1 918.5 929.4 938.9 944.9 17964.5 20631.0 21986.5 22276.3 22344.0 950.6 959.5 984.2 984.3 988.6 11361.3 11503.9 11711.0 11755.8 11811.2 779098.0 781051.0 783278.0 802458.0 802703.0 105397.7 133342.0 140419.3 140596.0 142534.0 1014.7 1033.5 1044.5 1046.8 1047.7 13997.0 19028.0 19431.6 19458.3 19545.0 54616.8 56003.4 56390.4 57075.4 59273.7 78999.0 80940.6 81953.6 82864.0 83248.2 6624.5 6686.4 7973.7 8198.6 8242.0 7516.0 11848.5 12271.8 12797.9 13344.7 11240.6 11439.5 11720.6 11845.5 11904.7 10904.2 11145.0 11390.7 11518.1 11613.9 8860.7 11413.1 11665.6 11961.9 12022.2 7402.9 7473.7 7992.8 8211.6 8308.1 10950.8 11452.5 11470.3 11573.9 11663.6 05:20:10 INFO - PROCESS | 1645 | 05:20:10 INFO - PROCESS | 1645 | [#3] mootools.html Cycles:180 Average:5475.15 Median:5173.86 stddev:2971.85 (57.4%) stddev-sans-first:2963.52 05:20:10 INFO - PROCESS | 1645 | Values: 1287.7 1425.2 1443.4 1447.7 1447.8 8124.9 8506.3 8517.7 8531.1 8540.7 7555.3 7767.4 8111.0 8328.4 8382.5 2331.4 2338.3 2341.3 2387.9 2389.9 2366.4 2385.7 2399.7 2404.0 2407.3 2004.9 2078.6 2082.0 2150.6 2345.6 2328.0 2334.2 2335.2 2335.7 2337.0 2301.4 2339.6 2374.1 2377.0 2381.4 8453.2 8488.2 8495.4 8497.4 8507.7 5097.7 5256.3 5265.1 5269.7 5273.2 3015.6 3366.9 3516.9 3581.1 3591.2 1128.1 1183.8 1194.8 1217.2 1263.3 10695.1 10792.0 10815.8 10866.6 10875.8 4454.1 4649.4 4677.0 4746.1 4758.1 9555.0 9555.1 9564.5 9570.5 9571.9 5233.4 5243.6 5247.1 5252.9 5264.0 4286.1 4423.2 4614.8 4711.6 4727.1 3831.5 3861.3 3918.0 3950.6 3963.3 1079.4 1268.1 1271.3 1283.5 1285.6 909.5 910.8 918.8 926.9 950.3 4797.5 5556.2 5758.6 5804.9 5849.6 993.1 1002.7 1005.6 1011.1 1042.3 3723.6 3878.5 3954.7 3965.9 4027.8 9829.0 10044.4 10082.3 10111.6 10182.5 9494.6 9915.3 9935.9 10016.1 10029.8 7757.9 7929.8 7930.0 7933.2 7966.4 5718.7 5764.5 5774.8 5840.7 6040.1 9333.6 9389.5 9403.8 9414.3 9415.0 8995.6 9366.0 9371.1 9464.2 9475.9 6627.9 6841.6 6854.9 7162.5 7312.6 7747.7 7823.2 7995.0 8096.6 8098.7 7075.5 7081.4 7180.3 7209.4 7291.3 7011.4 7103.2 7134.7 7262.3 7271.1 5447.2 6408.7 6411.7 6481.7 6489.9 4995.3 5028.8 5042.8 5056.8 5080.1 4880.0 4895.5 5062.9 5163.9 5183.8 05:20:10 INFO - PROCESS | 1645 | 05:20:10 INFO - PROCESS | 1645 | [#4] prototype.html Cycles:180 Average:4514.70 Median:4992.91 stddev:1330.34 (26.6%) stddev-sans-first:1296.10 05:20:10 INFO - PROCESS | 1645 | Values: 310.7 363.8 366.5 373.7 374.3 4780.0 4965.1 4966.9 5401.9 5403.9 4579.8 5051.4 5162.3 5327.6 5359.2 3621.9 3741.8 3962.4 4058.6 4168.7 3471.9 3938.7 4039.9 4152.5 4180.5 3478.3 3500.0 4010.7 4175.3 4180.7 3465.2 3980.9 4103.5 4174.0 4217.7 3129.5 3259.0 3684.6 3687.3 3722.5 5216.3 5226.9 5235.2 5307.6 5336.1 4051.8 4673.1 4824.8 4909.8 4913.0 4773.1 5723.9 5729.5 5741.1 5747.0 4107.9 4110.7 4112.3 4115.4 4144.4 4715.6 4784.7 5282.5 6015.6 6043.7 3524.9 3839.7 4029.0 4235.5 4241.7 4112.4 4282.9 4306.5 4311.4 4339.7 4723.8 4848.9 4872.5 4887.8 4917.2 4825.4 5047.2 5207.0 5494.9 5754.6 1297.0 1384.1 1385.2 1398.2 1402.6 904.5 927.4 969.4 981.6 994.1 4747.9 4950.5 4991.4 5007.4 5031.9 4808.6 4994.5 5470.6 5536.5 5587.8 4716.8 4752.5 4962.0 5005.4 5019.9 2661.4 2885.9 2918.7 2924.7 2933.0 5183.7 5219.4 5721.5 5746.6 5751.7 4768.9 4875.0 5288.8 5681.1 5746.0 4880.8 5254.2 5269.3 5699.5 5747.4 4775.5 5172.3 5540.4 5546.8 5559.4 5088.6 5186.0 5209.3 5229.7 5340.0 5126.6 5675.5 5767.5 5917.4 5982.5 3864.4 3894.9 3905.3 3907.2 3911.1 5775.6 5838.5 5840.5 5858.4 5860.9 4629.4 5287.9 5363.6 5421.8 5654.7 5025.0 5118.4 5649.2 5651.5 5653.1 5119.5 5325.3 5508.9 5532.9 5556.4 5583.3 5635.3 5642.5 5660.7 5664.3 4638.8 5051.8 5506.3 5527.5 5540.4 05:20:10 INFO - PROCESS | 1645 | 05:20:10 INFO - PROCESS | 1645 | [#5] yui.html Cycles:180 Average:19154.48 Median:4287.63 stddev:27069.37 (631.3%) stddev-sans-first:27109.93 05:20:10 INFO - PROCESS | 1645 | Values: 723.9 726.0 785.3 804.5 837.3 14889.9 15888.2 15917.2 15920.5 15952.8 14441.8 14636.3 14914.3 14922.0 14991.8 851.0 886.5 906.7 909.0 909.2 891.0 912.7 914.2 914.2 917.0 953.4 956.1 956.4 958.7 959.4 949.7 950.8 953.5 954.1 956.3 609.3 644.3 715.7 716.1 718.5 13641.5 13955.6 14036.6 14142.6 14165.6 12002.6 12112.0 12195.2 12282.5 12284.6 10651.9 10688.1 10959.4 10978.8 11104.8 3363.8 3505.2 3667.3 3770.8 3801.6 96693.5 100989.0 102268.0 102284.5 102705.5 9118.2 9170.4 9200.6 9234.4 9265.2 16577.6 19883.5 20039.3 20169.8 20218.0 7581.4 7860.1 7889.2 8067.3 8082.9 4282.2 4293.1 4438.1 4448.8 4507.5 3607.7 3666.6 3677.5 3745.0 3754.7 661.1 663.6 664.8 671.5 672.6 623.6 668.3 681.8 696.2 697.4 9883.3 10469.0 10561.9 10564.9 10891.2 687.2 715.2 715.3 721.5 724.8 4207.5 4641.2 5051.9 5075.1 5078.4 98386.0 98843.0 99432.5 99520.5 101160.0 55683.0 58892.5 60619.1 68261.7 89445.6 59340.7 75239.5 76684.0 77297.6 78557.0 10737.7 10946.4 11177.7 11202.6 11212.2 41673.9 44922.6 46442.8 48420.8 49758.8 58373.0 64700.1 65484.3 68966.3 69110.7 11295.5 12551.7 13013.4 13043.9 13077.1 12063.9 12151.3 12175.4 12535.9 13034.2 13206.7 13870.0 14142.9 14215.9 14981.1 12500.9 13800.3 14408.5 14517.2 14707.4 13170.4 13847.1 13959.7 14095.6 14156.6 10519.4 11100.2 11627.2 11777.5 11780.9 7246.0 10191.7 10311.4 11068.7 11133.3 05:20:10 INFO - PROCESS | 1645 | -------- Summary: end -------- 05:20:10 INFO - PROCESS | 1645 | 05:20:10 INFO - TEST-INFO | 1645: exit 0 05:20:10 INFO - TEST-OK | dromaeo_css | took 1117117ms 05:20:10 INFO - TEST-START | kraken 05:20:10 INFO - operating with platform_type : mac_ 05:20:10 INFO - Initialising browser for kraken test... 05:20:10 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpj9ocvn/profile http://localhost:49240/getInfo.html) 05:20:13 INFO - PROCESS | 1654 | __metrics Screen width/height:1600/1200 05:20:13 INFO - PROCESS | 1654 | colorDepth:24 05:20:13 INFO - PROCESS | 1654 | Browser inner width/height: 1024/689 05:20:13 INFO - PROCESS | 1654 | __metrics 05:20:13 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/webrtcUI.jsm, line 66: NS_ERROR_XPC_NOT_ENOUGH_ARGS: Not enough arguments [nsIMessageListenerManager.removeMessageListener] 05:20:13 INFO - PROCESS | 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:20:13 INFO - PROCESS | 1654 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:20:13 INFO - TEST-INFO | 1654: exit 0 05:20:13 INFO - Browser initialized. 05:20:13 INFO - Running cycle 1/1 for kraken test... 05:20:13 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/FirefoxDeveloperEdition.app/Contents/MacOS/firefox -foreground -profile /var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/T/tmpj9ocvn/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:20:26 INFO - PROCESS | 1655 | RSS: Main: 213360640 05:20:26 INFO - PROCESS | 1655 | 05:20:28 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection) 05:20:29 INFO - PROCESS | 1655 | RSS: Main: 263897088 05:20:29 INFO - PROCESS | 1655 | 05:20:32 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-dft) 05:20:32 INFO - PROCESS | 1655 | RSS: Main: 278482944 05:20:32 INFO - PROCESS | 1655 | 05:20:35 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-fft) 05:20:36 INFO - PROCESS | 1655 | RSS: Main: 374976512 05:20:36 INFO - PROCESS | 1655 | 05:20:38 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator) 05:20:39 INFO - PROCESS | 1655 | RSS: Main: 279289856 05:20:39 INFO - PROCESS | 1655 | 05:20:41 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:20:41 INFO - PROCESS | 1655 | RSS: Main: 279867392 05:20:41 INFO - PROCESS | 1655 | 05:20:44 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom) 05:20:45 INFO - PROCESS | 1655 | RSS: Main: 319295488 05:20:45 INFO - PROCESS | 1655 | 05:20:48 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate) 05:20:48 INFO - PROCESS | 1655 | RSS: Main: 319139840 05:20:48 INFO - PROCESS | 1655 | 05:20:51 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial) 05:20:52 INFO - PROCESS | 1655 | RSS: Main: 315904000 05:20:52 INFO - PROCESS | 1655 | 05:20:53 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:20:54 INFO - PROCESS | 1655 | RSS: Main: 293822464 05:20:54 INFO - PROCESS | 1655 | 05:20:56 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:20:56 INFO - PROCESS | 1655 | RSS: Main: 296988672 05:20:56 INFO - PROCESS | 1655 | 05:20:58 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:20:59 INFO - PROCESS | 1655 | RSS: Main: 301842432 05:20:59 INFO - PROCESS | 1655 | 05:21:02 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:21:03 INFO - PROCESS | 1655 | RSS: Main: 318541824 05:21:03 INFO - PROCESS | 1655 | 05:21:06 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:21:06 INFO - PROCESS | 1655 | RSS: Main: 312283136 05:21:06 INFO - PROCESS | 1655 | 05:21:08 INFO - PROCESS | 1655 | Cycle 1(1): loaded http://localhost:49240/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49240/tests/kraken/driver.html?testName=ai-astar) 05:21:08 INFO - PROCESS | 1655 | RSS: Main: 356900864 05:21:08 INFO - PROCESS | 1655 | 05:21:08 INFO - PROCESS | 1655 | __start_tp_report 05:21:08 INFO - PROCESS | 1655 | _x_x_mozilla_page_load 05:21:08 INFO - PROCESS | 1655 | _x_x_mozilla_page_load_details 05:21:08 INFO - PROCESS | 1655 | |i|pagename|runs| 05:21:08 INFO - PROCESS | 1655 | |0;ai-astar;109;115;114;115;113;115;112;115;114;115 05:21:08 INFO - PROCESS | 1655 | |1;audio-beat-detection;134;91;114;172;142;134;110;109;126;109 05:21:08 INFO - PROCESS | 1655 | |2;audio-dft;184;182;184;183;184;185;181;185;183;182 05:21:08 INFO - PROCESS | 1655 | |3;audio-fft;80;57;58;87;62;57;86;67;73;56 05:21:08 INFO - PROCESS | 1655 | |4;audio-oscillator;85;71;87;70;67;71;80;68;69;82 05:21:08 INFO - PROCESS | 1655 | |5;imaging-gaussian-blur;89;86;88;86;88;86;89;86;89;89 05:21:08 INFO - PROCESS | 1655 | |6;imaging-darkroom;99;99;98;100;98;98;109;154;98;97 05:21:08 INFO - PROCESS | 1655 | |7;imaging-desaturate;86;87;83;88;87;88;87;86;85;86 05:21:08 INFO - PROCESS | 1655 | |8;json-parse-financial;58;52;54;54;54;58;58;57;57;62 05:21:08 INFO - PROCESS | 1655 | |9;json-stringify-tinderbox;65;71;78;74;72;70;70;72;70;71 05:21:08 INFO - PROCESS | 1655 | |10;stanford-crypto-aes;86;87;86;83;84;82;84;85;89;86 05:21:08 INFO - PROCESS | 1655 | |11;stanford-crypto-ccm;145;146;146;135;137;151;152;152;195;153 05:21:08 INFO - PROCESS | 1655 | |12;stanford-crypto-pbkdf2;166;167;169;166;169;168;170;173;166;165 05:21:08 INFO - PROCESS | 1655 | |13;stanford-crypto-sha256-iterative;66;66;68;65;66;66;66;67;65;64 05:21:08 INFO - PROCESS | 1655 | __end_tp_report 05:21:08 INFO - PROCESS | 1655 | __start_cc_report 05:21:08 INFO - PROCESS | 1655 | _x_x_mozilla_cycle_collect,2018 05:21:08 INFO - PROCESS | 1655 | __end_cc_report 05:21:08 INFO - PROCESS | 1655 | __startTimestamp1485264068782__endTimestamp 05:21:08 INFO - PROCESS | 1655 | 05:21:08 INFO - PROCESS | 1655 | ------- Summary: start ------- 05:21:08 INFO - PROCESS | 1655 | Number of tests: 14 05:21:08 INFO - PROCESS | 1655 | 05:21:08 INFO - PROCESS | 1655 | [#0] ai-astar Cycles:10 Average:113.70 Median:115.00 stddev:1.95 (1.7%) stddev-sans-first:1.09 05:21:08 INFO - PROCESS | 1655 | Values: 109.0 115.0 114.0 115.0 113.0 115.0 112.0 115.0 114.0 115.0 05:21:08 INFO - PROCESS | 1655 | 05:21:08 INFO - PROCESS | 1655 | [#1] audio-beat-detection Cycles:10 Average:124.10 Median:134.00 stddev:22.77 (17.0%) stddev-sans-first:23.87 05:21:08 INFO - PROCESS | 1655 | Values: 134.0 91.0 114.0 172.0 142.0 134.0 110.0 109.0 126.0 109.0 05:21:08 INFO - PROCESS | 1655 | 05:21:08 INFO - PROCESS | 1655 | [#2] audio-dft Cycles:10 Average:183.30 Median:184.00 stddev:1.34 (0.7%) stddev-sans-first:1.39 05:21:08 INFO - PROCESS | 1655 | Values: 184.0 182.0 184.0 183.0 184.0 185.0 181.0 185.0 183.0 182.0 05:21:08 INFO - PROCESS | 1655 | 05:21:08 INFO - PROCESS | 1655 | [#3] audio-fft Cycles:10 Average:68.30 Median:70.00 stddev:12.37 (17.7%) stddev-sans-first:12.37 05:21:08 INFO - PROCESS | 1655 | Values: 80.0 57.0 58.0 87.0 62.0 57.0 86.0 67.0 73.0 56.0 05:21:08 INFO - PROCESS | 1655 | 05:21:08 INFO - PROCESS | 1655 | [#4] audio-oscillator Cycles:10 Average:75.00 Median:75.50 stddev:7.63 (10.1%) stddev-sans-first:7.18 05:21:08 INFO - PROCESS | 1655 | Values: 85.0 71.0 87.0 70.0 67.0 71.0 80.0 68.0 69.0 82.0 05:21:08 INFO - PROCESS | 1655 | 05:21:08 INFO - PROCESS | 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:87.60 Median:88.50 stddev:1.43 (1.6%) stddev-sans-first:1.42 05:21:08 INFO - PROCESS | 1655 | Values: 89.0 86.0 88.0 86.0 88.0 86.0 89.0 86.0 89.0 89.0 05:21:08 INFO - PROCESS | 1655 | 05:21:08 INFO - PROCESS | 1655 | [#6] imaging-darkroom Cycles:10 Average:105.00 Median:98.00 stddev:17.56 (17.9%) stddev-sans-first:18.49 05:21:08 INFO - PROCESS | 1655 | Values: 99.0 99.0 98.0 100.0 98.0 98.0 109.0 154.0 98.0 97.0 05:21:08 INFO - PROCESS | 1655 | 05:21:08 INFO - PROCESS | 1655 | [#7] imaging-desaturate Cycles:10 Average:86.30 Median:87.00 stddev:1.49 (1.7%) stddev-sans-first:1.58 05:21:08 INFO - PROCESS | 1655 | Values: 86.0 87.0 83.0 88.0 87.0 88.0 87.0 86.0 85.0 86.0 05:21:08 INFO - PROCESS | 1655 | 05:21:08 INFO - PROCESS | 1655 | [#8] json-parse-financial Cycles:10 Average:56.40 Median:57.50 stddev:2.91 (5.1%) stddev-sans-first:3.03 05:21:08 INFO - PROCESS | 1655 | Values: 58.0 52.0 54.0 54.0 54.0 58.0 58.0 57.0 57.0 62.0 05:21:08 INFO - PROCESS | 1655 | 05:21:08 INFO - PROCESS | 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:71.30 Median:71.50 stddev:3.30 (4.6%) stddev-sans-first:2.60 05:21:08 INFO - PROCESS | 1655 | Values: 65.0 71.0 78.0 74.0 72.0 70.0 70.0 72.0 70.0 71.0 05:21:08 INFO - PROCESS | 1655 | 05:21:08 INFO - PROCESS | 1655 | [#10] stanford-crypto-aes Cycles:10 Average:85.20 Median:86.00 stddev:2.04 (2.4%) stddev-sans-first:2.15 05:21:08 INFO - PROCESS | 1655 | Values: 86.0 87.0 86.0 83.0 84.0 82.0 84.0 85.0 89.0 86.0 05:21:08 INFO - PROCESS | 1655 | 05:21:08 INFO - PROCESS | 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:151.20 Median:151.50 stddev:16.60 (11.0%) stddev-sans-first:17.45 05:21:08 INFO - PROCESS | 1655 | Values: 145.0 146.0 146.0 135.0 137.0 151.0 152.0 152.0 195.0 153.0 05:21:08 INFO - PROCESS | 1655 | 05:21:08 INFO - PROCESS | 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:167.90 Median:168.50 stddev:2.42 (1.4%) stddev-sans-first:2.47 05:21:08 INFO - PROCESS | 1655 | Values: 166.0 167.0 169.0 166.0 169.0 168.0 170.0 173.0 166.0 165.0 05:21:08 INFO - PROCESS | 1655 | 05:21:08 INFO - PROCESS | 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:65.90 Median:66.00 stddev:1.10 (1.7%) stddev-sans-first:1.17 05:21:08 INFO - PROCESS | 1655 | Values: 66.0 66.0 68.0 65.0 66.0 66.0 66.0 67.0 65.0 64.0 05:21:08 INFO - PROCESS | 1655 | -------- Summary: end -------- 05:21:08 INFO - PROCESS | 1655 | 05:21:09 INFO - TEST-INFO | 1655: exit 0 05:21:09 INFO - TEST-OK | kraken | took 58958ms 05:21:09 INFO - SUITE-END | took 1176s 05:21:09 INFO - Completed test suite (00:19:36) 05:21:09 INFO - javascript benchmark 05:21:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2711.566149416093, 3295.719863811576, 3305.6033276006883, 3335.399628066947, 3357.6474470180647, 5719.4566516181, 5737.770489180433, 5771.826845194641, 5809.564282678795, 5815.970920145399, 5741.712914354286, 5799.18811366409, 5813.941860581393, 5829.387914268994, 5851.239338885939, 5234.345706786661, 5273.499017593323, 5276.841694749163, 5295.496927791873, 5329.920051199235, 5178.0161769263905, 5187.948120518784, 5190.195519694454, 5359.892802143955, 5407.83776486706, 5283.8150664726745, 5285.814996475124, 5308.654937429074, 5319.946800532003, 5321.707306098163, 5246.475352464761, 5249.895002099975, 5251.10731175701, 5289.338832645919, 5343.973280133613, 5195.454477279869, 5238.554722848562, 5272.051030814452, 5286.471352864683, 5319.946800531984, 5887.911681324784, 5893.44012318829, 5932.406759324076, 5975.163477113164, 5978.730957106941, 5166.715830629314, 6142.099766648166, 6170.629762214281, 6210.72051757672, 6216.129741836146, 6279.340669229757, 6323.525735569805, 6351.951927931886, 6361.395667411589, 6372.98032314832, 5898.41015898411, 5955.523558115384, 5966.880662386728, 5968.358701357161, 6006.978813601698, 6310.211223597051, 6323.146375239284, 6354.3963323484195, 6360.268569114519, 6377.075324077982, 6155.10750941111, 6159.045347971071, 6169.629822210682, 6171.907421388682, 6172.660503672341, 6261.655608941552, 6286.402791734778, 6293.527985401113, 6385.553011289165, 6395.6482393468805, 6289.591176573508, 6333.240011198685, 6341.985282354801, 6347.365263473708, 6362.331955144736, 4499.52754960731, 6216.098665693449, 6349.984002559569, 6352.904706429407, 6387.840303992437, 4943.036107958914, 4964.081644895634, 4990.80036798524, 4995.275685025724, 4995.475475075137, 4474.32885067236, 4488.708233964782, 4489.573490518395, 4512.819487220474, 4523.389342438729, 5756.992526307879, 5781.248437703071, 5796.478316951495, 5809.186713860063, 5812.970935145382, 6185.381461853779, 6278.686065696788, 6285.277193122758, 6319.747210111544, 6321.431071203522, 5639.774409023593, 5693.202951586781, 5699.173619825102, 5746.396628353963, 5830.62100963436, 5476.479734425223, 5509.0, 5514.558835293167, 5527.50252477279, 5543.334799824047, 6386.329435409215, 6411.455026322628, 6431.2604050533855, 6435.388638079375, 6452.22573291208, 6200.038993955944, 6269.467095296951, 6278.874422511615, 6283.622982621057, 6322.209723784527, 6331.0, 6392.552521323462, 6403.775867844603, 6414.871702565829, 6453.709583068867, 6291.811245662638, 6298.496120310272, 6302.1492098566105, 6306.905396418965, 6328.0, 6130.979101201984, 6232.563720539519, 6320.083587879823, 6329.461995730415, 6346.650934198478, 5149.588032957429, 6065.8180254592435, 6108.938910611015, 6214.720337584729, 6221.222347206599, 6167.982282923447, 6191.226096737908, 6197.752089916353, 6204.317525072148, 6206.224221972254, 5007.549320561167, 5862.208601838868, 5899.616524925866, 5995.550333725076, 6071.0, 5728.54171666274, 6071.7571297147615, 6124.197855633957, 6140.692965351804, 6227.159333490102, 6054.636721796706, 6063.363346848694, 6063.938810708197, 6070.271567411939, 6076.483498902466], "value": 5742.923629933804, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [458.6995517935751, 498.3098408703945, 502.4975024975025, 502.85417229003593, 506.37715609799943, 28019.719802801967, 33390.16524586886, 33435.49846752294, 33455.16362090943, 33469.66530334699, 42597.935051623645, 44659.0, 44733.7763311183, 46874.76562617191, 46974.0, 9439.575219115157, 9621.567029483655, 9639.325247232697, 9650.276229282797, 9663.323567350288, 8577.442466239705, 9504.192143667797, 9628.47043412612, 9639.951800241024, 9651.118031983766, 8640.913590864106, 11399.886001139965, 11583.594574189863, 11619.941900290487, 11835.467403966843, 11480.25378350413, 11534.423278836066, 11616.070714342832, 11644.883551164465, 11695.473703683312, 8508.78728031798, 11532.59635912739, 11534.769304613861, 11596.434481345079, 11620.825687614693, 31664.366712665847, 40805.38791918124, 41455.58544414547, 41543.37684934728, 43479.78260108711, 3491.336646037245, 3952.249072676211, 4034.899127521806, 4047.2917239483268, 4250.192463431938, 26591.335216619547, 29158.41683166325, 30490.54264186039, 30512.84743576268, 30765.0, 3158.0, 3179.761517886168, 3254.6094468663673, 3290.6051273847293, 3293.127321259868, 509156.9999999963, 510739.0, 513153.4342328302, 514050.0, 514997.0, 58959.41040589625, 59140.7042964791, 59240.111398329056, 59323.406765932654, 59354.0, 61807.690961545806, 61859.0, 61994.210260538384, 62052.069218961755, 62113.06830397547, 15778.13220272896, 16211.27049282785, 16227.0, 16280.0, 16282.592935176715, 12120.090993175547, 12443.0, 12582.622521324374, 12680.429380677891, 12684.0, 15640.4525841595, 15994.0, 18013.099345032697, 18275.54311142232, 18290.085495725427, 5462.863428414242, 6787.5588086774205, 7889.132195458495, 7911.666058512753, 8056.83886322282, 877.1579283887539, 892.3040028777564, 903.6159632156307, 905.1355955062899, 925.842606756853, 30038.279890628884, 30807.845960770053, 30869.845650771604, 30900.381992360028, 31482.212944676565, 1077.3912739302268, 1077.7251800790748, 1081.3349789879326, 1096.1395304685784, 1237.5049980007889, 15537.06777593348, 15944.123073230852, 16037.358505659642, 16127.681633303931, 16192.919035404748, 654214.0, 656909.7154514197, 658334.0, 659873.0, 660063.0, 62811.74376512444, 63005.73988520296, 63030.68484657639, 63391.36608633947, 63462.048069279, 1442.5528086293282, 1448.9120872099563, 1460.1239256446047, 1479.88900832438, 1482.9629259268388, 28955.855220724603, 29879.850600747726, 30598.541021884244, 30653.751826987744, 30696.84651576728, 46867.062658747316, 47060.0, 47121.52878471308, 47160.292595611776, 47190.05619887652, 536759.3162034322, 540276.0, 540844.0, 541761.0, 541894.0, 22628.208012719475, 26458.0, 26772.330691732863, 26995.190144295702, 27129.0, 39335.0, 42823.7858810704, 48652.0, 49027.50972490372, 52361.0, 38520.0, 38914.0, 39264.0, 40650.390244146955, 41052.384214237405, 40442.79778601088, 40564.0, 40714.9821254471, 40915.38626920539, 42113.36829947492, 38395.6160438392, 38754.0, 39060.0, 39156.0, 39264.6073539261, 34603.826980864935, 34716.47925281072, 35409.468857967666, 35504.46743298904, 35705.46441803427, 22657.980390882778, 25847.224583262534, 25895.482090358466, 26055.478890422466, 26430.471390572464], "value": 20221.328678759568, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [352.86943830782604, 389.08370786797093, 401.5021373496861, 404.2117870153202, 426.38813302910324, 14252.358643861025, 20323.390298291055, 21052.473688157803, 21608.459788505275, 21649.0, 16481.92338924622, 18478.260869565234, 21216.36350909475, 21484.892575537102, 21948.561028779415, 5254.868628284305, 5753.309602847664, 6106.542009349317, 6107.297660769002, 6108.267007959051, 5869.060950247961, 5991.850203744898, 5992.49063829575, 6071.150038994544, 6103.45068943795, 6048.39516048396, 6050.546209034318, 6051.878962420749, 6057.848553786146, 6072.696365181745, 5787.131930210481, 5946.821595352168, 6019.367966363513, 6029.427204415618, 6031.849203769897, 5223.869403264911, 5256.448072952361, 5258.55302299305, 5263.4999675031195, 5270.077736396153, 25035.37411564707, 26122.085726999652, 26179.0, 26321.07876224323, 26410.73589264102, 2325.2094287942014, 2788.4980703473366, 2829.2643912582876, 2855.6287682601337, 2861.184562399706, 14850.554483365517, 14973.1016139032, 15009.324580393799, 15280.235988200546, 15825.841741582552, 1684.6209602839385, 1790.1675720789895, 1810.63787242552, 1814.8475717919216, 1880.341880341883, 130736.99999999905, 134567.81559074813, 138255.6174438253, 138841.0, 140191.0, 9130.49782261982, 11044.134552906418, 11338.773224535627, 11373.270415100316, 11467.305183281922, 11838.585649502225, 14204.71590568183, 14221.715565688628, 14230.644233894029, 14235.28823558818, 7797.649105790253, 8183.0, 8190.672373105009, 8463.534505602127, 8591.226789588967, 8775.692850750193, 8802.955985220033, 8875.511846848356, 8878.467291962503, 9056.773580660536, 6934.098567186234, 7026.859462810715, 7033.1560212773775, 7070.434365250768, 7136.0, 1615.4668959243422, 1855.9628807423776, 1886.3869242496244, 1894.422201228611, 1898.1648074847024, 889.1330952321564, 918.5315489100607, 929.419113054341, 938.8732521109563, 944.9102335278137, 17964.531616917437, 20631.0, 21986.45033874166, 22276.331710048402, 22344.0, 950.6405839649368, 959.4531117263233, 984.1683777208248, 984.3306551544875, 988.604558176735, 11361.318320900773, 11503.942480287546, 11711.0, 11755.764884702428, 11811.232269902428, 779098.0, 781051.0, 783278.0, 802458.0, 802703.0, 105397.73011349402, 133342.0, 140419.29790351188, 140596.0, 142534.0, 1014.6955913226003, 1033.493588141805, 1044.4829809244472, 1046.7697106636529, 1047.6699839550517, 13997.0, 19028.0, 19431.61136777285, 19458.31895883637, 19545.022748862786, 54616.81532738646, 56003.43996559982, 56390.43609563852, 57075.42924570867, 59273.70363148156, 78999.0, 80940.59529702314, 81953.59023204846, 82864.0, 83248.16751832646, 6624.503162262753, 6686.398224159849, 7973.681052757825, 8198.590070496331, 8242.010958684756, 7516.0, 11848.526058957545, 12271.75456490883, 12797.872021279669, 13344.733105338033, 11240.606578769704, 11439.485223164811, 11720.589779357682, 11845.466953987263, 11904.702382440162, 10904.182186336215, 11145.0, 11390.715232118931, 11518.07855371585, 11613.941930290295, 8860.689875854314, 11413.144014198802, 11665.59170429031, 11961.940190298992, 12022.158448908493, 7402.888956665762, 7473.738419155304, 7992.84014319722, 8211.58942052907, 8308.086110527958, 10950.780984380428, 11452.541898324307, 11470.254433461798, 11573.942130289632, 11663.59177428786], "value": 9973.955505009466, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1287.7424515096982, 1425.1662777275294, 1443.4442739545273, 1447.7321695486337, 1447.7900704397855, 8124.918750812498, 8506.319494440446, 8517.701880434186, 8531.146885311473, 8540.658373665061, 7555.282248186427, 7767.417443691717, 8110.959445202766, 8328.417010809246, 8382.538960357178, 2331.4287999440076, 2338.286822519135, 2341.309313752439, 2387.916422925198, 2389.916352927648, 2366.3610825077217, 2385.7494963028894, 2399.6520504526834, 2404.0, 2407.2898494943947, 2004.9498762530907, 2078.5738923520717, 2082.011044753737, 2150.6451435513122, 2345.589521833681, 2328.0338659456306, 2334.2063698342645, 2335.2293743064834, 2335.7313908900524, 2337.0418128567376, 2301.401635574746, 2339.5554844579474, 2374.1453076892303, 2376.988115059431, 2381.357033600935, 8453.239208471266, 8488.236058754741, 8495.447795893248, 8497.447665901696, 8507.702230421968, 5097.668651537638, 5256.316678831766, 5265.052290587692, 5269.710165940872, 5273.209018647195, 3015.6079709637825, 3366.898993030213, 3516.8944931651836, 3581.1405262737017, 3591.191981804099, 1128.05807151029, 1183.8401815754935, 1194.832723418722, 1217.2148963918223, 1263.298869127643, 10695.144388448984, 10792.0, 10815.83776243357, 10866.61966831157, 10875.78248435027, 4454.086912182995, 4649.418822647169, 4677.017826256524, 4746.07451546952, 4758.119747846659, 9555.0, 9555.092266234697, 9564.521773911416, 9570.47362395075, 9571.856422153673, 5233.398159211663, 5243.580513558906, 5247.134222853187, 5252.894942101137, 5263.973680131651, 4286.099919017041, 4423.203823311835, 4614.792334344963, 4711.646626503026, 4727.101850648366, 3831.540215174197, 3861.3242682530445, 3917.9608203918165, 3950.6246906543834, 3963.326234540135, 1079.4063265204106, 1268.055298802398, 1271.3007845684836, 1283.4673610451744, 1285.6078895936641, 909.4906852162678, 910.8132832769398, 918.779492921694, 926.9073092690812, 950.2540505703129, 4797.472278049412, 5556.166575013699, 5758.596898217168, 5804.9419505805245, 5849.619774714715, 993.1310103659298, 1002.6791426743372, 1005.597760895633, 1011.1203253169789, 1042.3485321673954, 3723.6408710820897, 3878.5151856017997, 3954.6638535724787, 3965.940510892339, 4027.778472184058, 9828.950855245821, 10044.397336159855, 10082.344647597884, 10111.64609238673, 10182.541785619665, 9494.620215191315, 9915.256355773347, 9935.850962235572, 10016.098551130288, 10029.79940401188, 7757.883631745528, 7929.762107136795, 7930.0, 7933.206679332136, 7966.442349035628, 5718.742656580381, 5764.452377024176, 5774.82675519735, 5840.707964601668, 6040.124181993674, 9333.626654933727, 9389.48357840298, 9403.764905877408, 9414.293927955294, 9415.011423800675, 8995.595198215966, 9366.016568260235, 9371.109744574254, 9464.242860571276, 9475.905240947503, 6627.933720662924, 6841.589504629539, 6854.897176542456, 7162.462815288978, 7312.634368281671, 7747.6513556891205, 7823.217678232359, 7994.960655114798, 8096.595170241582, 8098.676052957816, 7075.50471467013, 7081.398081163159, 7180.281971802778, 7209.423246140401, 7291.34377905991, 7011.4390848733, 7103.218645949045, 7134.678939447841, 7262.31008054234, 7271.091113610799, 5447.182922561489, 6408.743650253938, 6411.679416029273, 6481.675916204265, 6489.9026514603265, 4995.300657907823, 5028.84913452597, 5042.84871453857, 5056.84829455117, 5080.060188865072, 4879.975600121977, 4895.534924182197, 5062.898742025212, 5163.948360516347, 5183.766730497061], "value": 4458.105610896108, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [310.6598274888996, 363.75414206343265, 366.5070480204125, 373.704773229149, 374.305662995144, 4780.0, 4965.063625186176, 4966.875828104299, 5401.945980540203, 5403.9197657335335, 4579.839705610304, 5051.419086805018, 5162.277281180638, 5327.600429967749, 5359.196120581914, 3621.8551257949653, 3741.7754934703867, 3962.385830196317, 4058.6347228749405, 4168.729032612886, 3471.8542880849386, 3938.6652134568594, 4039.899002524931, 4152.460180176573, 4180.519240287375, 3478.2521757822065, 3500.0, 4010.6590939770153, 4175.331946888498, 4180.707350485467, 3465.203003309253, 3980.900477488057, 4103.466549348565, 4174.019105510202, 4217.746935183899, 3129.5305704144334, 3259.0060031690564, 3684.613115622875, 3687.3362794696945, 3722.497462842509, 5216.347956505437, 5226.947730522722, 5235.240890070919, 5307.575393968474, 5336.119540275849, 4051.837926482967, 4673.112108699336, 4824.789227634146, 4909.7790599423115, 4913.017396520674, 4773.064565292355, 5723.885522289531, 5729.512991395736, 5741.1388291756575, 5746.971265143689, 4107.856225032109, 4110.691698122623, 4112.3420252759415, 4115.382692596135, 4144.41978123063, 4715.575598196145, 4784.665073444826, 5282.524572788468, 6015.608985415934, 6043.7280322385595, 3524.8674551896247, 3839.7328881469048, 4029.0, 4235.53409124996, 4241.745495270294, 4112.362583799516, 4282.892927676833, 4306.504751953503, 4311.353297005474, 4339.717918335298, 4723.834665786681, 4848.8787780305065, 4872.512748725099, 4887.780049897763, 4917.213245880642, 4825.372701548777, 5047.2429135629945, 5207.0, 5494.917576236359, 5754.597178197486, 1297.0, 1384.1487485196733, 1385.2035079829138, 1398.2449477282153, 1402.6423262068108, 904.4889637354873, 927.3879239701764, 969.4328817641617, 981.5779214937503, 994.1152374386802, 4747.8575642730775, 4950.480199578992, 4991.376077990251, 5007.4241462231585, 5031.949680503149, 4808.591269742041, 4994.450610432922, 5470.64440811354, 5536.501714845684, 5587.842868779208, 4716.834910778106, 4752.477227504972, 4961.975190124026, 5005.4483110235215, 5019.874503137451, 2661.3765602982166, 2885.898993535216, 2918.693537178608, 2924.707529247101, 2932.985335073311, 5183.688978661217, 5219.373675159005, 5721.5136713379825, 5746.569007324468, 5751.712414379264, 4768.883431694833, 4874.975625121851, 5288.848254120497, 5681.062624666966, 5746.0, 4880.780364883518, 5254.211868219798, 5269.257668098742, 5699.458551437607, 5747.4252574742195, 4775.450823155382, 5172.250023746611, 5540.390557038803, 5546.833594992157, 5559.360673522435, 5088.618353623419, 5186.0, 5209.348831396075, 5229.731417863835, 5339.997500937148, 5126.56424203932, 5675.545956323567, 5767.500449882977, 5917.437843404869, 5982.49148822355, 3864.42033694948, 3894.9221015578964, 3905.3165696002516, 3907.199024199975, 3911.1395492991496, 5775.556110972257, 5838.474537291664, 5840.503557197686, 5858.443447872445, 5860.912086318794, 4629.375034370317, 5287.889543195972, 5363.597730170331, 5421.810236641699, 5654.717264136694, 5025.0, 5118.360204974379, 5649.152627105967, 5651.463111004448, 5653.095504719389, 5119.539241468286, 5325.307709997831, 5508.862278443071, 5532.91700624499, 5556.444195625231, 5583.302087239095, 5635.323761148688, 5642.489092353863, 5660.7169641518585, 5664.320281566238, 4638.8144474222, 5051.751970373149, 5506.284183056177, 5527.474889885454, 5540.390557038803], "value": 4110.121939778645, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [723.8552289542093, 725.9891101633473, 785.2696991797626, 804.537391000175, 837.2924878477686, 14889.851101488983, 15888.205589720497, 15917.204139793022, 15920.522384328475, 15952.840471595266, 14441.783373249384, 14636.268186590654, 14914.254287285647, 14922.0, 14991.775123373158, 850.9829803403959, 886.5079880666227, 906.7370462565848, 909.0, 909.231699214163, 890.9732708018737, 912.6988093928987, 914.2092090341873, 914.2411798207505, 916.9679061232858, 953.4184147669915, 956.1251454918776, 956.4118067388541, 958.6692591056075, 959.357230655459, 949.7008442340641, 950.752804270891, 953.4660590069583, 954.1317401164976, 956.3257903178243, 609.3053918532876, 644.310587671192, 715.7029832619456, 716.0512321174465, 718.4503854551273, 13641.522546710918, 13955.58133256004, 14036.649083772885, 14142.575722728334, 14165.645858853508, 12002.63992080239, 12112.0, 12195.207311524722, 12282.508699652004, 12284.637517518682, 10651.946740266327, 10688.09151222147, 10959.397233152173, 10978.780424391547, 11104.777904441948, 3363.7722231385615, 3505.1587618971516, 3667.2848794485085, 3770.7926064066464, 3801.600831912637, 96693.51653241689, 100989.0, 102268.0, 102284.48857755738, 102705.4864725679, 9118.179363857285, 9170.44977301364, 9200.631974720936, 9234.353595248402, 9265.2124569411, 16577.585560361087, 19883.502912427306, 20039.29862454807, 20169.798302017087, 20218.0, 7581.355584775356, 7860.135385107634, 7889.2110788920645, 8067.3142782864115, 8082.9191708083345, 4282.207791558571, 4293.055527783882, 4438.134563760101, 4448.755318457516, 4507.549245075466, 3607.7113830893463, 3666.6333366663653, 3677.5219221501034, 3744.970133213388, 3754.662080412776, 661.1438187547042, 663.6117871045492, 664.833791552112, 671.4561205423524, 672.6098862659743, 623.5884316351187, 668.2882729892649, 681.8125015620744, 696.2445746365149, 697.4106879686657, 9883.308168428284, 10469.020500002422, 10561.894381056245, 10564.947175264075, 10891.237613366988, 687.2303020616941, 715.1632589869864, 715.3275920634587, 721.4625104297332, 724.840535082281, 4207.516135644379, 4641.187792136363, 5051.87370315745, 5075.086484432837, 5078.390593128848, 98386.0, 98843.0, 99432.5028374868, 99520.50239748899, 101160.0, 55683.0, 58892.52768680817, 60619.09071363933, 68261.65869170622, 89445.55277223572, 59340.70329648324, 75239.4952100955, 76684.0, 77297.6135119332, 78557.0, 10737.677869663923, 10946.39794811293, 11177.72055698614, 11202.551897923991, 11212.215144939775, 41673.91293545877, 44922.550774491836, 46442.76778616085, 48420.757896211704, 49758.75120624374, 58373.0, 64700.05899823013, 65484.345156547824, 68966.31033689599, 69110.65444672745, 11295.491702873225, 12551.748965020832, 13013.414396352377, 13043.934780326037, 13077.149985250928, 12063.879361206276, 12151.331676757509, 12175.391230438265, 12535.874641253471, 13034.217946923214, 13206.735865282833, 13870.0, 14142.858571414154, 14215.857841421453, 14981.101133932, 12500.937495312466, 13800.309984500936, 14408.495702650356, 14517.201553914636, 14707.411703532167, 13170.407331669907, 13847.108771755753, 13959.678022279426, 14095.577132686036, 14156.575302740934, 10519.368837869752, 11100.222984391015, 11627.186096973131, 11777.52889884395, 11780.941095294469, 7246.0, 10191.694249172537, 10311.432871192157, 11068.723281918017, 11133.332000080021], "value": 7381.585204816254, "unit": "score"}], "name": "dromaeo_css", "value": 7342.355650875331, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [109.0, 115.0, 114.0, 115.0, 113.0, 115.0, 112.0, 115.0, 114.0, 115.0], "value": 113.7, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [134.0, 91.0, 114.0, 172.0, 142.0, 134.0, 110.0, 109.0, 126.0, 109.0], "value": 124.1, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 182.0, 184.0, 183.0, 184.0, 185.0, 181.0, 185.0, 183.0, 182.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 58.0, 87.0, 62.0, 57.0, 86.0, 67.0, 73.0, 56.0], "value": 68.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 71.0, 87.0, 70.0, 67.0, 71.0, 80.0, 68.0, 69.0, 82.0], "value": 75.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 86.0, 88.0, 86.0, 88.0, 86.0, 89.0, 86.0, 89.0, 89.0], "value": 87.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [99.0, 99.0, 98.0, 100.0, 98.0, 98.0, 109.0, 154.0, 98.0, 97.0], "value": 105.0, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 83.0, 88.0, 87.0, 88.0, 87.0, 86.0, 85.0, 86.0], "value": 86.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [58.0, 52.0, 54.0, 54.0, 54.0, 58.0, 58.0, 57.0, 57.0, 62.0], "value": 56.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 71.0, 78.0, 74.0, 72.0, 70.0, 70.0, 72.0, 70.0, 71.0], "value": 71.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 87.0, 86.0, 83.0, 84.0, 82.0, 84.0, 85.0, 89.0, 86.0], "value": 85.2, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [145.0, 146.0, 146.0, 135.0, 137.0, 151.0, 152.0, 152.0, 195.0, 153.0], "value": 151.2, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [166.0, 167.0, 169.0, 166.0, 169.0, 168.0, 170.0, 173.0, 166.0, 165.0], "value": 167.9, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 66.0, 68.0, 65.0, 66.0, 66.0, 66.0, 67.0, 65.0, 64.0], "value": 65.9, "unit": "score"}], "name": "kraken", "value": 1441.2000000000003, "alertThreshold": 2.0}]} 05:21:10 INFO - Return code: 0 05:21:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:21:10 ERROR - # TBPL SUCCESS # 05:21:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:21:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:21:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:21:10 INFO - 2017-01-24 05:21:10.102 screenresolution[1659:9756] starting screenresolution argv=screenresolution get 05:21:10 INFO - 2017-01-24 05:21:10.104 screenresolution[1659:9756] Display 0: 1600x1200x32@60 05:21:10 INFO - 2017-01-24 05:21:10.110 screenresolution[1660:9759] starting screenresolution argv=screenresolution list 05:21:10 INFO - Available Modes on Display 0 05:21:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:21:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:21:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:21:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:21:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:21:10 INFO - Intel Iris: 05:21:10 INFO - Chipset Model: Intel Iris 05:21:10 INFO - Type: GPU 05:21:10 INFO - Bus: Built-In 05:21:10 INFO - VRAM (Dynamic, Max): 1536 MB 05:21:10 INFO - Vendor: Intel (0x8086) 05:21:10 INFO - Device ID: 0x0a2e 05:21:10 INFO - Revision ID: 0x0009 05:21:10 INFO - Displays: 05:21:10 INFO - Display: 05:21:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:21:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:21:10 INFO - Display Serial Number: 1600x1200 60 05:21:10 INFO - Main Display: Yes 05:21:10 INFO - Mirror: Off 05:21:10 INFO - Online: Yes 05:21:10 INFO - Rotation: Supported 05:21:10 INFO - Return code: 0 05:21:10 INFO - Running post-action listener: _resource_record_post_action 05:21:10 INFO - [mozharness: 2017-01-24 13:21:10.346519Z] Finished run-tests step (success) 05:21:10 INFO - Running post-run listener: _resource_record_post_run 05:21:10 INFO - Total resource usage - Wall time: 1196s; CPU: 54.0%; Read bytes: 37471232; Write bytes: 504833024; Read time: 233; Write time: 1590 05:21:10 INFO - TinderboxPrint: CPU usage
53.7% 05:21:10 INFO - TinderboxPrint: I/O read bytes / time
37,471,232 / 233 05:21:10 INFO - TinderboxPrint: I/O write bytes / time
504,833,024 / 1,590 05:21:10 INFO - TinderboxPrint: CPU idle
2,217.2 (46.3%) 05:21:10 INFO - TinderboxPrint: CPU system
961.0 (20.1%) 05:21:10 INFO - TinderboxPrint: CPU user
1,607.4 (33.6%) 05:21:10 INFO - TinderboxPrint: Swap in / out
245,219,328 / 0 05:21:10 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 208697856; Write bytes: 209905152; Read time: 15878; Write time: 480 05:21:10 INFO - run-tests - Wall time: 1177s; CPU: 54.0%; Read bytes: 33924096; Write bytes: 293350912; Read time: 208; Write time: 1105 05:21:10 INFO - Running post-run listener: _upload_blobber_files 05:21:10 INFO - Blob upload gear active. 05:21:10 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:21:10 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 05:21:10 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-Aurora', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:21:10 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-Aurora -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:21:11 INFO - (blobuploader) - INFO - Open directory for files ... 05:21:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:21:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:21:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:12 INFO - (blobuploader) - INFO - Done attempting. 05:21:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:21:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:21:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:13 INFO - (blobuploader) - INFO - Done attempting. 05:21:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:21:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:21:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:14 INFO - (blobuploader) - INFO - Done attempting. 05:21:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:21:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:21:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:21:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:21:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:21:16 INFO - (blobuploader) - INFO - Done attempting. 05:21:16 INFO - (blobuploader) - INFO - Iteration through files over. 05:21:16 INFO - Return code: 0 05:21:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:21:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:21:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2dc849a44d6c7ccab391d4e8201aa2782e3a12004ce77c73b2751e4dee307aa085a2e8351fe6d8f47e1a9d1b3fa27fbf495d2a5473824c78e82f644eb5c3d53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36e97b9c8faa1f3ee9c81e97bc5a4f15a1134ae6e497cd32c01cc03cffcf18557e06cbc94cbd5335a399e74e5090ab876e8aa3b7e461148c04e7b6a7a13f831d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0be498d568a921328d13d0faaab38774ebd058152e9e89c5d5477552a19dab2756eed2884865981462c4b602e20ff845ec36255daa6513b4e2af4f0fa9cfffc0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/124859d20bde8d1adcf4ca097a2442002421a1d19869fe27b785a687e8b3c8c8e05caae821caaee0484a713c83f278736b435cd65af0ab00021133b9b96a565b"} 05:21:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:21:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:21:16 INFO - Contents: 05:21:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2dc849a44d6c7ccab391d4e8201aa2782e3a12004ce77c73b2751e4dee307aa085a2e8351fe6d8f47e1a9d1b3fa27fbf495d2a5473824c78e82f644eb5c3d53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36e97b9c8faa1f3ee9c81e97bc5a4f15a1134ae6e497cd32c01cc03cffcf18557e06cbc94cbd5335a399e74e5090ab876e8aa3b7e461148c04e7b6a7a13f831d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0be498d568a921328d13d0faaab38774ebd058152e9e89c5d5477552a19dab2756eed2884865981462c4b602e20ff845ec36255daa6513b4e2af4f0fa9cfffc0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/124859d20bde8d1adcf4ca097a2442002421a1d19869fe27b785a687e8b3c8c8e05caae821caaee0484a713c83f278736b435cd65af0ab00021133b9b96a565b"} 05:21:16 INFO - Running post-run listener: copy_logs_to_upload_dir 05:21:16 INFO - Copying logs to upload dir... 05:21:16 INFO - mkdir: /builds/slave/test/build/upload/logs 05:21:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1260.302723 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 0 secs) (at 2017-01-24 05:21:16.965227) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 05:21:16.968777) ========= 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.z4BZLI55DC/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.tnpbOvPEwZ/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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-Aurora/sha512/c2dc849a44d6c7ccab391d4e8201aa2782e3a12004ce77c73b2751e4dee307aa085a2e8351fe6d8f47e1a9d1b3fa27fbf495d2a5473824c78e82f644eb5c3d53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36e97b9c8faa1f3ee9c81e97bc5a4f15a1134ae6e497cd32c01cc03cffcf18557e06cbc94cbd5335a399e74e5090ab876e8aa3b7e461148c04e7b6a7a13f831d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0be498d568a921328d13d0faaab38774ebd058152e9e89c5d5477552a19dab2756eed2884865981462c4b602e20ff845ec36255daa6513b4e2af4f0fa9cfffc0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/124859d20bde8d1adcf4ca097a2442002421a1d19869fe27b785a687e8b3c8c8e05caae821caaee0484a713c83f278736b435cd65af0ab00021133b9b96a565b"} build_url:https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011056 build_url: 'https://queue.taskcluster.net/v1/task/IYj7d_rhQz2TxLIpTiJ7IQ/artifacts/public/build/firefox-53.0a2.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/c2dc849a44d6c7ccab391d4e8201aa2782e3a12004ce77c73b2751e4dee307aa085a2e8351fe6d8f47e1a9d1b3fa27fbf495d2a5473824c78e82f644eb5c3d53", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/36e97b9c8faa1f3ee9c81e97bc5a4f15a1134ae6e497cd32c01cc03cffcf18557e06cbc94cbd5335a399e74e5090ab876e8aa3b7e461148c04e7b6a7a13f831d", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/0be498d568a921328d13d0faaab38774ebd058152e9e89c5d5477552a19dab2756eed2884865981462c4b602e20ff845ec36255daa6513b4e2af4f0fa9cfffc0", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Mozilla-Aurora/sha512/124859d20bde8d1adcf4ca097a2442002421a1d19869fe27b785a687e8b3c8c8e05caae821caaee0484a713c83f278736b435cd65af0ab00021133b9b96a565b"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-24 05:21:17.002421) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 05:21:17.002756) ========= 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.z4BZLI55DC/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.tnpbOvPEwZ/Listeners TMPDIR=/var/folders/1b/b370xjvx7_vbkyyr8hgyjzcm00000w/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.004969 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-24 05:21:17.052212) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 05:21:17.052556) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-24 05:21:17.052879) ========= ========= Total master_lag: 0.18 =========