builder: pine_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0078 starttime: 1490012028.76 results: success (0) buildid: 20170320031642 builduid: 0ed5008b36d14b04a0fc152f3f973830 revision: 33fcf9ad89c2d256d07a001878357e0034065438 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 05:13:48.755899) ========= master: http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-03-20 05:13:48.756364) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 05:13:48.756648) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-03-20 05:13:48.783473) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 05:13:48.783809) ========= 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.u5IS0nUcfL/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.Pv3N13f6nG/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-03-20 05:13:48-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.25, 63.245.215.102 Connecting to hg.mozilla.org|63.245.215.25|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.94M=0.001s 2017-03-20 05:13:48 (7.94 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.129215 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 05:13:48.936455) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 05:13:48.936777) ========= 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.u5IS0nUcfL/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.Pv3N13f6nG/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.023897 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 05:13:48.989541) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 05:13:48.989994) ========= bash -c 'python archiver_client.py mozharness --repo projects/pine --rev 33fcf9ad89c2d256d07a001878357e0034065438 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo projects/pine --rev 33fcf9ad89c2d256d07a001878357e0034065438 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u5IS0nUcfL/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.Pv3N13f6nG/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-03-20 05:13:49,078 truncating revision to first 12 chars 2017-03-20 05:13:49,078 Setting DEBUG logging. 2017-03-20 05:13:49,078 attempt 1/10 2017-03-20 05:13:49,078 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/projects/pine/33fcf9ad89c2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-03-20 05:13:50,611 unpacking tar archive at: pine-33fcf9ad89c2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.784438 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-03-20 05:13:50.801520) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 05:13:50.801827) ========= script_repo_revision: 33fcf9ad89c2d256d07a001878357e0034065438 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-03-20 05:13:50.802226) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 05:13:50.802492) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-03-20 05:13:50.822193) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-20 05:13:50.822506) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 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', 'Pine', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Pine'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.u5IS0nUcfL/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.Pv3N13f6nG/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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:13:51 INFO - MultiFileLogger online at 20170320 05:13:51 in /builds/slave/test 05:13:51 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Pine --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Pine 05:13:51 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:13:51 INFO - {'append_to_log': False, 05:13:51 INFO - 'base_work_dir': '/builds/slave/test', 05:13:51 INFO - 'blob_upload_branch': 'Pine', 05:13:51 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:13:51 INFO - 'branch': 'Pine', 05:13:51 INFO - 'buildbot_json_path': 'buildprops.json', 05:13:51 INFO - 'config_files': ('talos/mac_config.py',), 05:13:51 INFO - 'default_actions': ('clobber', 05:13:51 INFO - 'read-buildbot-config', 05:13:51 INFO - 'download-and-extract', 05:13:51 INFO - 'populate-webroot', 05:13:51 INFO - 'create-virtualenv', 05:13:51 INFO - 'install', 05:13:51 INFO - 'run-tests'), 05:13:51 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:13:51 INFO - 'download_minidump_stackwalk': True, 05:13:51 INFO - 'download_symbols': 'ondemand', 05:13:51 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:13:51 INFO - 'tooltool.py': '/tools/tooltool.py', 05:13:51 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:13:51 INFO - '/tools/misc-python/virtualenv.py')}, 05:13:51 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:13:51 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:13:51 INFO - 'gecko_profile': False, 05:13:51 INFO - 'gecko_profile_interval': 0, 05:13:51 INFO - 'installer_path': 'installer.exe', 05:13:51 INFO - 'log_level': 'info', 05:13:51 INFO - 'log_name': 'talos', 05:13:51 INFO - 'log_to_console': True, 05:13:51 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:13:51 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:13:51 INFO - 'opt_config_files': (), 05:13:51 INFO - 'pip_index': False, 05:13:51 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:13:51 INFO - 'cmd': ('bash', 05:13:51 INFO - '-c', 05:13:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:13:51 INFO - 'enabled': True, 05:13:51 INFO - 'halt_on_failure': False, 05:13:51 INFO - 'name': 'check_screen_resolution'},), 05:13:51 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:13:51 INFO - 'cmd': ('bash', 05:13:51 INFO - '-c', 05:13:51 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:13:51 INFO - 'enabled': True, 05:13:51 INFO - 'halt_on_failure': False, 05:13:51 INFO - 'name': 'check_screen_resolution'},), 05:13:51 INFO - 'run_cmd_checks_enabled': True, 05:13:51 INFO - 'suite': 'dromaeojs', 05:13:51 INFO - 'system_bits': '32', 05:13:51 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:13:51 INFO - 'title': 't-yosemite-r7-0078', 05:13:51 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:13:51 INFO - 'use_talos_json': True, 05:13:51 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:13:51 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:13:51 INFO - 'work_dir': 'build'} 05:13:51 INFO - [mozharness: 2017-03-20 12:13:51.033082Z] Running clobber step. 05:13:51 INFO - Running pre-action listener: _resource_record_pre_action 05:13:51 INFO - Running main action method: clobber 05:13:51 INFO - rmtree: /builds/slave/test/build 05:13:51 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:13:53 INFO - Running post-action listener: _resource_record_post_action 05:13:53 INFO - [mozharness: 2017-03-20 12:13:53.063844Z] Finished clobber step (success) 05:13:53 INFO - [mozharness: 2017-03-20 12:13:53.064026Z] Running read-buildbot-config step. 05:13:53 INFO - Running pre-action listener: _resource_record_pre_action 05:13:53 INFO - Running main action method: read_buildbot_config 05:13:53 INFO - Using buildbot properties: 05:13:53 INFO - { 05:13:53 INFO - "project": "", 05:13:53 INFO - "product": "firefox", 05:13:53 INFO - "script_repo_revision": "default", 05:13:53 INFO - "builddir": "pine_yosemite_r7_test-dromaeojs", 05:13:53 INFO - "repository": "", 05:13:53 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 pine talos dromaeojs", 05:13:53 INFO - "buildid": "20170320031642", 05:13:53 INFO - "pgo_build": "False", 05:13:53 INFO - "basedir": "/builds/slave/test", 05:13:53 INFO - "buildnumber": 0, 05:13:53 INFO - "slavename": "t-yosemite-r7-0078", 05:13:53 INFO - "master": "http://buildbot-master132.bb.releng.scl3.mozilla.com:8201/", 05:13:53 INFO - "platform": "yosemite_r7", 05:13:53 INFO - "scheduler": "tests-pine-macosx64-talos", 05:13:53 INFO - "branch": "pine", 05:13:53 INFO - "repo_path": "projects/pine", 05:13:53 INFO - "revision": "33fcf9ad89c2d256d07a001878357e0034065438", 05:13:53 INFO - "stage_platform": "macosx64", 05:13:53 INFO - "builduid": "0ed5008b36d14b04a0fc152f3f973830", 05:13:53 INFO - "slavebuilddir": "test" 05:13:53 INFO - } 05:13:53 INFO - Found installer url https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 05:13:53 INFO - Running post-action listener: _resource_record_post_action 05:13:53 INFO - [mozharness: 2017-03-20 12:13:53.067086Z] Finished read-buildbot-config step (success) 05:13:53 INFO - [mozharness: 2017-03-20 12:13:53.067199Z] Running download-and-extract step. 05:13:53 INFO - Running pre-action listener: _resource_record_pre_action 05:13:53 INFO - Running main action method: download_and_extract 05:13:53 INFO - mkdir: /builds/slave/test/build/tests 05:13:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:13:53 INFO - trying https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 05:13:53 INFO - Downloading https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:13:53 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 05:13:54 INFO - Downloaded 1325 bytes. 05:13:54 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:13:54 INFO - Using the following test package requirements: 05:13:54 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:13:54 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 05:13:54 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:13:54 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:13:54 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 05:13:54 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:13:54 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 05:13:54 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:13:54 INFO - u'jsshell-mac.zip'], 05:13:54 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:13:54 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 05:13:54 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:13:54 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:13:54 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 05:13:54 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:13:54 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 05:13:54 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:13:54 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 05:13:54 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:13:54 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 05:13:54 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:13:54 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:13:54 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:13:54 INFO - Fetch https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:13:55 INFO - Expected file size: 52473008 05:13:55 INFO - Obtained file size: 52473008 05:14:12 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:14:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:14:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:14:12 INFO - Fetch https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:14:14 INFO - Expected file size: 52473008 05:14:14 INFO - Obtained file size: 52473008 05:14:29 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 05:14:29 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:14:29 INFO - Fetch https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 05:14:30 INFO - Expected file size: 14404171 05:14:30 INFO - Obtained file size: 14404171 05:14:31 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:31 INFO - trying https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:14:31 INFO - Downloading https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 05:14:31 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 05:14:33 INFO - Downloaded 75191207 bytes. 05:14:33 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:14:33 INFO - mkdir: /builds/slave/test/properties 05:14:33 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:14:33 INFO - Writing to file /builds/slave/test/properties/build_url 05:14:33 INFO - Contents: 05:14:33 INFO - build_url:https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:14:33 INFO - Running post-action listener: _resource_record_post_action 05:14:33 INFO - Running post-action listener: set_extra_try_arguments 05:14:33 INFO - [mozharness: 2017-03-20 12:14:33.804637Z] Finished download-and-extract step (success) 05:14:33 INFO - [mozharness: 2017-03-20 12:14:33.804741Z] Running populate-webroot step. 05:14:33 INFO - Running pre-action listener: _resource_record_pre_action 05:14:33 INFO - Running main action method: populate_webroot 05:14:33 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:14:33 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:14:33 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:14:33 INFO - '--tppagecycles', 05:14:33 INFO - '7'], 05:14:33 INFO - 'tests': ['tsvgm']}}, 05:14:33 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:14:33 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:14:33 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:14:33 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:14:33 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:14:33 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:14:33 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:14:33 INFO - 'talos_options': ['--disable-e10s'], 05:14:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:33 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:14:33 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:14:33 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:14:33 INFO - 'talos_options': ['--disable-e10s'], 05:14:33 INFO - 'tests': ['damp', 'tps']}, 05:14:33 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:14:33 INFO - 'tests': ['damp', 'tps']}, 05:14:33 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:14:33 INFO - 'tests': ['dromaeo_dom']}, 05:14:33 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:14:33 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:14:33 INFO - 'tests': ['basic_compositor_video']}, 05:14:33 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 05:14:33 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:14:33 INFO - 'tests': ['a11yr', 05:14:33 INFO - 'ts_paint', 05:14:33 INFO - 'tpaint', 05:14:33 INFO - 'sessionrestore', 05:14:33 INFO - 'sessionrestore_no_auto_restore', 05:14:33 INFO - 'tabpaint']}, 05:14:33 INFO - 'other-e10s': {'tests': ['a11yr', 05:14:33 INFO - 'ts_paint', 05:14:33 INFO - 'tpaint', 05:14:33 INFO - 'sessionrestore', 05:14:33 INFO - 'sessionrestore_no_auto_restore', 05:14:33 INFO - 'tabpaint']}, 05:14:33 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:14:33 INFO - 'ts_paint', 05:14:33 INFO - 'tpaint', 05:14:33 INFO - 'sessionrestore', 05:14:33 INFO - 'sessionrestore_no_auto_restore', 05:14:33 INFO - 'tabpaint']}, 05:14:33 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:14:33 INFO - 'ts_paint', 05:14:33 INFO - 'tpaint', 05:14:33 INFO - 'sessionrestore', 05:14:33 INFO - 'sessionrestore_no_auto_restore', 05:14:33 INFO - 'tabpaint']}, 05:14:33 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:14:33 INFO - 'tests': ['a11yr', 05:14:33 INFO - 'ts_paint', 05:14:33 INFO - 'tpaint', 05:14:33 INFO - 'sessionrestore', 05:14:33 INFO - 'sessionrestore_no_auto_restore', 05:14:33 INFO - 'tabpaint']}, 05:14:33 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:14:33 INFO - 'tests': ['a11yr', 05:14:33 INFO - 'ts_paint', 05:14:33 INFO - 'tpaint', 05:14:33 INFO - 'sessionrestore', 05:14:33 INFO - 'sessionrestore_no_auto_restore', 05:14:33 INFO - 'tabpaint']}, 05:14:33 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:14:33 INFO - 'tests': ['tsvgx', 05:14:33 INFO - 'tsvgr_opacity', 05:14:33 INFO - 'tart', 05:14:33 INFO - 'tscrollx', 05:14:33 INFO - 'cart', 05:14:33 INFO - 'tsvg_static']}, 05:14:33 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:14:33 INFO - 'tsvgr_opacity', 05:14:33 INFO - 'tart', 05:14:33 INFO - 'tscrollx', 05:14:33 INFO - 'cart', 05:14:33 INFO - 'tsvg_static']}, 05:14:33 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:14:33 INFO - 'talos_options': ['--disable-e10s'], 05:14:33 INFO - 'tests': ['tp5o']}, 05:14:33 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:14:33 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:14:33 INFO - 'talos_options': ['--disable-e10s', 05:14:33 INFO - '--xperf_path', 05:14:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:33 INFO - 'tests': ['tp5n']}, 05:14:33 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:14:33 INFO - 'talos_options': ['--xperf_path', 05:14:33 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:14:33 INFO - 'tests': ['tp5n']}}, 05:14:33 INFO - 'talos.zip': {'path': '', 05:14:33 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:14:33 INFO - Running post-action listener: _resource_record_post_action 05:14:33 INFO - [mozharness: 2017-03-20 12:14:33.822908Z] Finished populate-webroot step (success) 05:14:33 INFO - [mozharness: 2017-03-20 12:14:33.823001Z] Running create-virtualenv step. 05:14:33 INFO - Running pre-action listener: _resource_record_pre_action 05:14:33 INFO - Running main action method: create_virtualenv 05:14:33 INFO - Creating virtualenv /builds/slave/test/build/venv 05:14:33 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:14:33 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:14:33 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:14:33 INFO - Using real prefix '/tools/python27' 05:14:33 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:14:34 INFO - Installing distribute.............................................................................................................................................................................................done. 05:14:37 INFO - Installing pip.................done. 05:14:37 INFO - Return code: 0 05:14:37 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:14:37 INFO - Reading from file tmpfile_stdout 05:14:37 INFO - Output received: 05:14:37 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:14:37 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:37 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:37 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10a582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd969dec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a360d30>, '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 0x10a287db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a355be8>, '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.u5IS0nUcfL/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.Pv3N13f6nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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:14:37 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:14:37 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:14:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5IS0nUcfL/Render', 05:14:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:37 INFO - 'HOME': '/Users/cltbld', 05:14:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:37 INFO - 'LOGNAME': 'cltbld', 05:14:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:37 INFO - 'MOZ_NO_REMOTE': '1', 05:14:37 INFO - 'NO_EM_RESTART': '1', 05:14:37 INFO - 'PAGER': '/bin/cat', 05:14:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:37 INFO - 'PWD': '/builds/slave/test', 05:14:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:37 INFO - 'SHELL': '/bin/bash', 05:14:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Pv3N13f6nG/Listeners', 05:14:37 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:14:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:37 INFO - 'USER': 'cltbld', 05:14:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:37 INFO - 'XPC_FLAGS': '0x0', 05:14:37 INFO - 'XPC_SERVICE_NAME': '0', 05:14:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:38 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:14:38 INFO - Cleaning up... 05:14:38 INFO - Return code: 0 05:14:38 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:38 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 0x10a582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd969dec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a360d30>, '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 0x10a287db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a355be8>, '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.u5IS0nUcfL/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.Pv3N13f6nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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:14:38 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:14:38 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:14:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5IS0nUcfL/Render', 05:14:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:38 INFO - 'HOME': '/Users/cltbld', 05:14:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:38 INFO - 'LOGNAME': 'cltbld', 05:14:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:38 INFO - 'MOZ_NO_REMOTE': '1', 05:14:38 INFO - 'NO_EM_RESTART': '1', 05:14:38 INFO - 'PAGER': '/bin/cat', 05:14:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:38 INFO - 'PWD': '/builds/slave/test', 05:14:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:38 INFO - 'SHELL': '/bin/bash', 05:14:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Pv3N13f6nG/Listeners', 05:14:38 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:14:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:38 INFO - 'USER': 'cltbld', 05:14:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:38 INFO - 'XPC_FLAGS': '0x0', 05:14:38 INFO - 'XPC_SERVICE_NAME': '0', 05:14:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:38 INFO - Downloading/unpacking psutil>=3.1.1 05:14:38 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:14:38 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:14:38 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:14:38 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:14:38 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:14:38 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:14:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:14:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:42 INFO - Installing collected packages: psutil 05:14:42 INFO - Running setup.py install for psutil 05:14:42 INFO - building 'psutil._psutil_osx' extension 05:14:42 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:14:42 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:14:42 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:14:42 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:14:42 INFO - building 'psutil._psutil_posix' extension 05:14:42 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:14:42 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:14:42 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:14:42 INFO - ^ 05:14:42 INFO - 1 warning generated. 05:14:42 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:14:42 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:14:42 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:14:42 INFO - Successfully installed psutil 05:14:42 INFO - Cleaning up... 05:14:43 INFO - Return code: 0 05:14:43 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:14: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:14:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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:14:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:44 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 0x10a582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd969dec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a360d30>, '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 0x10a287db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a355be8>, '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.u5IS0nUcfL/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.Pv3N13f6nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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:14:44 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:14:44 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:14:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5IS0nUcfL/Render', 05:14:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:44 INFO - 'HOME': '/Users/cltbld', 05:14:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:44 INFO - 'LOGNAME': 'cltbld', 05:14:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:44 INFO - 'MOZ_NO_REMOTE': '1', 05:14:44 INFO - 'NO_EM_RESTART': '1', 05:14:44 INFO - 'PAGER': '/bin/cat', 05:14:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:44 INFO - 'PWD': '/builds/slave/test', 05:14:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:44 INFO - 'SHELL': '/bin/bash', 05:14:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Pv3N13f6nG/Listeners', 05:14:44 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:14:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:44 INFO - 'USER': 'cltbld', 05:14:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:44 INFO - 'XPC_FLAGS': '0x0', 05:14:44 INFO - 'XPC_SERVICE_NAME': '0', 05:14:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:44 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:14: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:14: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:14: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:14: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:14: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:14: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:14:47 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:14:47 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:14:47 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:14:47 INFO - Installing collected packages: mozsystemmonitor 05:14:47 INFO - Running setup.py install for mozsystemmonitor 05:14:47 INFO - Successfully installed mozsystemmonitor 05:14:47 INFO - Cleaning up... 05:14:47 INFO - Return code: 0 05:14:47 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:14:47 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:14:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:47 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:14:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:47 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 0x10a582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd969dec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a360d30>, '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 0x10a287db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a355be8>, '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.u5IS0nUcfL/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.Pv3N13f6nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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:14:47 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:14:47 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:14:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5IS0nUcfL/Render', 05:14:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:47 INFO - 'HOME': '/Users/cltbld', 05:14:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:47 INFO - 'LOGNAME': 'cltbld', 05:14:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:47 INFO - 'MOZ_NO_REMOTE': '1', 05:14:47 INFO - 'NO_EM_RESTART': '1', 05:14:47 INFO - 'PAGER': '/bin/cat', 05:14:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:47 INFO - 'PWD': '/builds/slave/test', 05:14:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:47 INFO - 'SHELL': '/bin/bash', 05:14:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Pv3N13f6nG/Listeners', 05:14:47 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:14:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:47 INFO - 'USER': 'cltbld', 05:14:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:47 INFO - 'XPC_FLAGS': '0x0', 05:14:47 INFO - 'XPC_SERVICE_NAME': '0', 05:14:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:47 INFO - Downloading/unpacking jsonschema==2.5.1 05:14:47 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:14:47 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:14:47 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:14:47 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:14:47 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:14:47 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:14:50 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:14:50 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:14:50 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:14:50 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:14:50 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:14:50 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:14:50 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:14:50 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:14:50 INFO - Downloading functools32-3.2.3-2.tar.gz 05:14:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:14:50 INFO - warning: no files found matching '*.txt' 05:14:50 INFO - no previously-included directories found matching 'build' 05:14:50 INFO - no previously-included directories found matching 'dist' 05:14:50 INFO - no previously-included directories found matching '.git*' 05:14:50 INFO - Installing collected packages: jsonschema, functools32 05:14:50 INFO - Running setup.py install for functools32 05:14:51 INFO - warning: no files found matching '*.txt' 05:14:51 INFO - no previously-included directories found matching 'build' 05:14:51 INFO - no previously-included directories found matching 'dist' 05:14:51 INFO - no previously-included directories found matching '.git*' 05:14:51 INFO - Successfully installed jsonschema functools32 05:14:51 INFO - Cleaning up... 05:14:51 INFO - Return code: 0 05:14:51 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd969dec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a360d30>, '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 0x10a287db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a355be8>, '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.u5IS0nUcfL/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.Pv3N13f6nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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:14:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:14:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5IS0nUcfL/Render', 05:14:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:51 INFO - 'HOME': '/Users/cltbld', 05:14:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:51 INFO - 'LOGNAME': 'cltbld', 05:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:51 INFO - 'MOZ_NO_REMOTE': '1', 05:14:51 INFO - 'NO_EM_RESTART': '1', 05:14:51 INFO - 'PAGER': '/bin/cat', 05:14:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:51 INFO - 'PWD': '/builds/slave/test', 05:14:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:51 INFO - 'SHELL': '/bin/bash', 05:14:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Pv3N13f6nG/Listeners', 05:14:51 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:14:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:51 INFO - 'USER': 'cltbld', 05:14:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:51 INFO - 'XPC_FLAGS': '0x0', 05:14:51 INFO - 'XPC_SERVICE_NAME': '0', 05:14:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:51 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:14:51 INFO - Cleaning up... 05:14:51 INFO - Return code: 0 05:14:51 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:51 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:51 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:14:51 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:51 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:51 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10a582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd969dec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a360d30>, '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 0x10a287db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a355be8>, '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.u5IS0nUcfL/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.Pv3N13f6nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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:14:51 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:14:51 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:14:51 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5IS0nUcfL/Render', 05:14:51 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:51 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:51 INFO - 'HOME': '/Users/cltbld', 05:14:51 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:51 INFO - 'LOGNAME': 'cltbld', 05:14:51 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:51 INFO - 'MOZ_NO_REMOTE': '1', 05:14:51 INFO - 'NO_EM_RESTART': '1', 05:14:51 INFO - 'PAGER': '/bin/cat', 05:14:51 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:51 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:51 INFO - 'PWD': '/builds/slave/test', 05:14:51 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:51 INFO - 'SHELL': '/bin/bash', 05:14:51 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Pv3N13f6nG/Listeners', 05:14:51 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:14:51 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:51 INFO - 'USER': 'cltbld', 05:14:51 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:51 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:51 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:51 INFO - 'XPC_FLAGS': '0x0', 05:14:51 INFO - 'XPC_SERVICE_NAME': '0', 05:14:51 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:51 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:51 INFO - Downloading/unpacking blobuploader==1.2.4 05:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:14:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:14:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:14:54 INFO - Downloading blobuploader-1.2.4.tar.gz 05:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:14:54 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:14:54 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:14:54 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:14:54 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:14:54 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:14:54 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:14:54 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:14:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:14:55 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:14:55 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:14:55 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:14:55 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:14:55 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:14:55 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:14:55 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:14:55 INFO - Downloading docopt-0.6.1.tar.gz 05:14:55 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:14:55 INFO - Installing collected packages: blobuploader, requests, docopt 05:14:55 INFO - Running setup.py install for blobuploader 05:14:55 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:14:55 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:14:55 INFO - Running setup.py install for requests 05:14:56 INFO - Running setup.py install for docopt 05:14:56 INFO - Successfully installed blobuploader requests docopt 05:14:56 INFO - Cleaning up... 05:14:56 INFO - Return code: 0 05:14:56 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:14: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:14:56 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:14:56 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14: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:14:56 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:14:56 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:14:56 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 0x10a582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd969dec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a360d30>, '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 0x10a287db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a355be8>, '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.u5IS0nUcfL/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.Pv3N13f6nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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:14:56 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:14:56 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:14:56 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5IS0nUcfL/Render', 05:14:56 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:14:56 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:14:56 INFO - 'HOME': '/Users/cltbld', 05:14:56 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:14:56 INFO - 'LOGNAME': 'cltbld', 05:14:56 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:14:56 INFO - 'MOZ_NO_REMOTE': '1', 05:14:56 INFO - 'NO_EM_RESTART': '1', 05:14:56 INFO - 'PAGER': '/bin/cat', 05:14:56 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:14:56 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:14:56 INFO - 'PWD': '/builds/slave/test', 05:14:56 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:14:56 INFO - 'SHELL': '/bin/bash', 05:14:56 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Pv3N13f6nG/Listeners', 05:14:56 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:14:56 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:14:56 INFO - 'USER': 'cltbld', 05:14:56 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:14:56 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:14:56 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:14:56 INFO - 'XPC_FLAGS': '0x0', 05:14:56 INFO - 'XPC_SERVICE_NAME': '0', 05:14:56 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:14:56 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:14:56 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-3y6lPj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:14:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:14:56 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-T_aQGA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:14:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-LOp15W-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:14:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-66GCpb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:14:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-1lpEZb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:14:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-DOX1h6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:14:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-4QMQWW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:14:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-zx0VHG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:14:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-KCzdUK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:14:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-vJhkWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:14:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-QWZ_X6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:14:57 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:14:57 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-JC5I6q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:14:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-5x5OCS-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:14:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-L9mN8F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-LFvH1m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:14:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-D8SEQx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:14:58 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:14:58 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-CpAG5z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:14:58 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:14:58 INFO - Running setup.py install for manifestparser 05:14:58 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:14:58 INFO - Running setup.py install for mozcrash 05:14:58 INFO - Running setup.py install for mozdebug 05:14:59 INFO - Running setup.py install for mozdevice 05:14:59 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 05:14:59 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:14:59 INFO - Running setup.py install for mozfile 05:14:59 INFO - Running setup.py install for mozhttpd 05:14:59 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:14:59 INFO - Running setup.py install for mozinfo 05:14:59 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:14:59 INFO - Running setup.py install for mozInstall 05:14:59 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:14:59 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:14:59 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:14:59 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:14:59 INFO - Running setup.py install for mozleak 05:14:59 INFO - Running setup.py install for mozlog 05:15:00 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:15:00 INFO - Running setup.py install for moznetwork 05:15:00 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:15:00 INFO - Running setup.py install for mozprocess 05:15:00 INFO - Running setup.py install for mozprofile 05:15:00 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:15:00 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:15:00 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:15:00 INFO - Running setup.py install for mozrunner 05:15:00 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:15:00 INFO - Running setup.py install for mozscreenshot 05:15:00 INFO - Running setup.py install for moztest 05:15:01 INFO - Running setup.py install for mozversion 05:15:01 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:15:01 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:15:01 INFO - Cleaning up... 05:15:01 INFO - Return code: 0 05:15:01 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:01 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:15:01 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:01 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:01 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:15:01 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:01 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:01 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 0x10a582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd969dec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a360d30>, '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 0x10a287db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a355be8>, '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.u5IS0nUcfL/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.Pv3N13f6nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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:15:01 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:15:01 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:15:01 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5IS0nUcfL/Render', 05:15:01 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:01 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:01 INFO - 'HOME': '/Users/cltbld', 05:15:01 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:01 INFO - 'LOGNAME': 'cltbld', 05:15:01 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:01 INFO - 'MOZ_NO_REMOTE': '1', 05:15:01 INFO - 'NO_EM_RESTART': '1', 05:15:01 INFO - 'PAGER': '/bin/cat', 05:15:01 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:01 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:01 INFO - 'PWD': '/builds/slave/test', 05:15:01 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:01 INFO - 'SHELL': '/bin/bash', 05:15:01 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Pv3N13f6nG/Listeners', 05:15:01 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:15:01 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:01 INFO - 'USER': 'cltbld', 05:15:01 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:01 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:01 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:01 INFO - 'XPC_FLAGS': '0x0', 05:15:01 INFO - 'XPC_SERVICE_NAME': '0', 05:15:01 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:01 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:15:01 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-dJe7sJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:15:01 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:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:15:01 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-XjXILo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:15:01 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:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:15:01 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-pPh3X4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:15:01 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:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:15:01 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-miAm0v-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:15:01 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:15:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:15:01 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-CFRQYG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:15:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-Ulisqv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:15:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-ojp78I-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:15:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-xzK3Zh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:15:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-hZVQtJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:15:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-iMrGzR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:15:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-Zec4hK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:15:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-l1M2oG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:15:02 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:15:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-7DZKIQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:15:02 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:15:02 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:15:02 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-J_kJvo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:15:03 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:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:03 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-THb0kt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:15:03 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:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:15:03 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-bimdOW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:15:03 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:15:03 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:15:03 INFO - Running setup.py (path:/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/pip-A_GOgw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:15:03 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:15:03 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:15:03 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:15:03 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:15:03 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:15:03 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:15:03 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:15:03 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:15:03 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:15:03 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:15:03 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:15:03 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:15:03 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:15:05 INFO - Downloading blessings-1.6.tar.gz 05:15:05 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:15:06 INFO - Installing collected packages: blessings 05:15:06 INFO - Running setup.py install for blessings 05:15:06 INFO - Successfully installed blessings 05:15:06 INFO - Cleaning up... 05:15:06 INFO - Return code: 0 05:15:06 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:15:06 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:06 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:06 INFO - Reading from file tmpfile_stdout 05:15:06 INFO - Current package versions: 05:15:06 INFO - blessings == 1.6 05:15:06 INFO - blobuploader == 1.2.4 05:15:06 INFO - docopt == 0.6.1 05:15:06 INFO - functools32 == 3.2.3-2 05:15:06 INFO - jsonschema == 2.5.1 05:15:06 INFO - manifestparser == 1.1 05:15:06 INFO - mozInstall == 1.12 05:15:06 INFO - mozcrash == 1.0 05:15:06 INFO - mozdebug == 0.1 05:15:06 INFO - mozdevice == 0.49 05:15:06 INFO - mozfile == 1.2 05:15:06 INFO - mozhttpd == 0.7 05:15:06 INFO - mozinfo == 0.9 05:15:06 INFO - mozleak == 0.1 05:15:06 INFO - mozlog == 3.4 05:15:06 INFO - moznetwork == 0.27 05:15:06 INFO - mozprocess == 0.25 05:15:06 INFO - mozprofile == 0.28 05:15:06 INFO - mozrunner == 6.13 05:15:06 INFO - mozscreenshot == 0.1 05:15:06 INFO - mozsystemmonitor == 0.3 05:15:06 INFO - moztest == 0.8 05:15:06 INFO - mozversion == 1.4 05:15:06 INFO - psutil == 3.1.1 05:15:06 INFO - requests == 1.2.3 05:15:06 INFO - wsgiref == 0.1.2 05:15:06 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:06 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 0x10a582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd969dec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a360d30>, '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 0x10a287db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a355be8>, '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.u5IS0nUcfL/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.Pv3N13f6nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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:15:06 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:15:06 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:15:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5IS0nUcfL/Render', 05:15:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:06 INFO - 'HOME': '/Users/cltbld', 05:15:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:06 INFO - 'LOGNAME': 'cltbld', 05:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:06 INFO - 'MOZ_NO_REMOTE': '1', 05:15:06 INFO - 'NO_EM_RESTART': '1', 05:15:06 INFO - 'PAGER': '/bin/cat', 05:15:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:06 INFO - 'PWD': '/builds/slave/test', 05:15:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:06 INFO - 'SHELL': '/bin/bash', 05:15:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Pv3N13f6nG/Listeners', 05:15:06 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:15:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:06 INFO - 'USER': 'cltbld', 05:15:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:06 INFO - 'XPC_FLAGS': '0x0', 05:15:06 INFO - 'XPC_SERVICE_NAME': '0', 05:15:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:06 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:06 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:15:06 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:15:06 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:15:06 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:15:06 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:15:06 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:15:06 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:15:06 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:15:06 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:15:06 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:15:06 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:15:06 INFO - Cleaning up... 05:15:06 INFO - Return code: 0 05:15:06 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:06 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:15:06 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:06 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:06 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:15:06 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:15:06 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 0x10a582b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a585768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fd969dec230>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10a360d30>, '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 0x10a287db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a355be8>, '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.u5IS0nUcfL/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.Pv3N13f6nG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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:15:06 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:15:06 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:15:06 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5IS0nUcfL/Render', 05:15:06 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:06 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:06 INFO - 'HOME': '/Users/cltbld', 05:15:06 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:06 INFO - 'LOGNAME': 'cltbld', 05:15:06 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:06 INFO - 'MOZ_NO_REMOTE': '1', 05:15:06 INFO - 'NO_EM_RESTART': '1', 05:15:06 INFO - 'PAGER': '/bin/cat', 05:15:06 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:06 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:06 INFO - 'PWD': '/builds/slave/test', 05:15:06 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:06 INFO - 'SHELL': '/bin/bash', 05:15:06 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Pv3N13f6nG/Listeners', 05:15:06 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:15:06 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:06 INFO - 'USER': 'cltbld', 05:15:06 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:06 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:06 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:06 INFO - 'XPC_FLAGS': '0x0', 05:15:06 INFO - 'XPC_SERVICE_NAME': '0', 05:15:06 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:07 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:15:07 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:15:07 INFO - Cleaning up... 05:15:07 INFO - Return code: 0 05:15:07 INFO - Running post-action listener: _resource_record_post_action 05:15:07 INFO - Running post-action listener: _start_resource_monitoring 05:15:07 INFO - Starting resource monitoring. 05:15:07 INFO - [mozharness: 2017-03-20 12:15:07.187512Z] Finished create-virtualenv step (success) 05:15:07 INFO - [mozharness: 2017-03-20 12:15:07.188564Z] Running install step. 05:15:07 INFO - Running pre-action listener: _resource_record_pre_action 05:15:07 INFO - Running main action method: install 05:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:15:07 INFO - Reading from file tmpfile_stdout 05:15:07 INFO - Detecting whether we're running mozinstall >=1.0... 05:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:15:07 INFO - Reading from file tmpfile_stdout 05:15:07 INFO - Output received: 05:15:07 INFO - Usage: mozinstall [options] installer 05:15:07 INFO - Options: 05:15:07 INFO - -h, --help show this help message and exit 05:15:07 INFO - -d DEST, --destination=DEST 05:15:07 INFO - Directory to install application into. [default: 05:15:07 INFO - "/builds/slave/test"] 05:15:07 INFO - --app=APP Application being installed. [default: firefox] 05:15:07 INFO - mkdir: /builds/slave/test/build/application 05:15:07 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:15:07 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:15:27 INFO - Reading from file tmpfile_stdout 05:15:27 INFO - Output received: 05:15:27 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 05:15:27 INFO - Running post-action listener: _resource_record_post_action 05:15:27 INFO - [mozharness: 2017-03-20 12:15:27.751295Z] Finished install step (success) 05:15:27 INFO - [mozharness: 2017-03-20 12:15:27.751449Z] Running run-tests step. 05:15:27 INFO - Running pre-action listener: _resource_record_pre_action 05:15:27 INFO - Running main action method: run_tests 05:15:27 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:15:27 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:15:27 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:15:27 INFO - 2017-03-20 05:15:27.766 screenresolution[6772:128784] starting screenresolution argv=screenresolution get 05:15:27 INFO - 2017-03-20 05:15:27.769 screenresolution[6772:128784] Display 0: 1600x1200x32@60 05:15:27 INFO - 2017-03-20 05:15:27.775 screenresolution[6773:128787] starting screenresolution argv=screenresolution list 05:15:27 INFO - Available Modes on Display 0 05:15:27 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:15:27 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:15:27 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:15:27 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:15:28 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:15:28 INFO - Intel Iris: 05:15:28 INFO - Chipset Model: Intel Iris 05:15:28 INFO - Type: GPU 05:15:28 INFO - Bus: Built-In 05:15:28 INFO - VRAM (Dynamic, Max): 1536 MB 05:15:28 INFO - Vendor: Intel (0x8086) 05:15:28 INFO - Device ID: 0x0a2e 05:15:28 INFO - Revision ID: 0x0009 05:15:28 INFO - Displays: 05:15:28 INFO - Display: 05:15:28 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:15:28 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:15:28 INFO - Display Serial Number: 1600x1200 60 05:15:28 INFO - Main Display: Yes 05:15:28 INFO - Mirror: Off 05:15:28 INFO - Online: Yes 05:15:28 INFO - Rotation: Supported 05:15:28 INFO - Return code: 0 05:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:15:28 INFO - Python 2.7.3 05:15:28 INFO - Return code: 0 05:15:28 INFO - grabbing minidump binary from tooltool 05:15:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:28 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 0x10a360d30>, '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 0x10a287db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10a355be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:15:28 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:15:28 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:15:28 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:15:28 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:15:28 INFO - Return code: 0 05:15:28 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:15:28 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:15:28 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:15:28 INFO - ENV: RUST_BACKTRACE is now 1 05:15:28 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:15:28 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:15:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--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:15:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Pine --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0078 --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:15:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.u5IS0nUcfL/Render', 05:15:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:15:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:15:28 INFO - 'HOME': '/Users/cltbld', 05:15:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:15:28 INFO - 'LOGNAME': 'cltbld', 05:15:28 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:15:28 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:15:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:15:28 INFO - 'MOZ_NO_REMOTE': '1', 05:15:28 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:15:28 INFO - 'NO_EM_RESTART': '1', 05:15:28 INFO - 'PAGER': '/bin/cat', 05:15:28 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:15:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:15:28 INFO - 'PWD': '/builds/slave/test', 05:15:28 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:15:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:15:28 INFO - 'RUST_BACKTRACE': '1', 05:15:28 INFO - 'SHELL': '/bin/bash', 05:15:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Pv3N13f6nG/Listeners', 05:15:28 INFO - 'TMPDIR': '/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/', 05:15:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:15:28 INFO - 'USER': 'cltbld', 05:15:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:15:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:15:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:15:28 INFO - 'XPC_FLAGS': '0x0', 05:15:28 INFO - 'XPC_SERVICE_NAME': '0', 05:15:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:15:28 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Pine', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0078', '--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:15:28 INFO - mozversion application_buildid: 20170320031642 05:15:28 INFO - mozversion application_changeset: 33fcf9ad89c2d256d07a001878357e0034065438 05:15:28 INFO - mozversion application_display_name: Nightly 05:15:28 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:15:28 INFO - mozversion application_name: Firefox 05:15:28 INFO - mozversion application_remotingname: firefox 05:15:28 INFO - mozversion application_repository: https://hg.mozilla.org/projects/pine 05:15:28 INFO - mozversion application_vendor: Mozilla 05:15:28 INFO - mozversion application_version: 55.0a1 05:15:28 INFO - mozversion platform_buildid: 20170320031642 05:15:28 INFO - mozversion platform_changeset: 33fcf9ad89c2d256d07a001878357e0034065438 05:15:28 INFO - mozversion platform_repository: https://hg.mozilla.org/projects/pine 05:15:28 INFO - mozversion platform_version: 55.0a1 05:15:28 INFO - using testdate: 1490012128 05:15:28 INFO - actual date: 1490012128 05:15:28 INFO - starting webserver on 'localhost:59904' 05:15:28 INFO - SUITE-START | Running 2 tests 05:15:28 INFO - TEST-START | dromaeo_css 05:15:28 INFO - operating with platform_type : mac_ 05:15:28 INFO - Initialising browser for dromaeo_css test... 05:15:28 INFO - TEST-INFO | started process 6783 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpp5UNGB/profile http://localhost:59904/getInfo.html) 05:15:31 INFO - PID 6783 | __metrics Screen width/height:1600/1200 05:15:31 INFO - PID 6783 | colorDepth:24 05:15:31 INFO - PID 6783 | Browser inner width/height: 1024/689 05:15:31 INFO - PID 6783 | __metrics 05:15:31 INFO - PID 6783 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:15:31 INFO - PID 6783 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:15:31 INFO - TEST-INFO | 6783: exit 0 05:15:31 INFO - Browser initialized. 05:15:31 INFO - Running cycle 1/1 for dromaeo_css test... 05:15:31 INFO - TEST-INFO | started process 6785 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmpp5UNGB/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:15:43 INFO - PID 6785 | RSS: Main: 233439232 05:15:43 INFO - PID 6785 | 05:18:47 INFO - PID 6785 | Cycle 1(1): loaded http://localhost:59904/tests/dromaeo/cssquery-dojo.html (next: http://localhost:59904/tests/dromaeo/cssquery-ext.html) 05:18:50 INFO - PID 6785 | RSS: Main: 418148352 05:18:50 INFO - PID 6785 | 05:20:34 INFO - PID 6785 | ************************* 05:20:34 INFO - PID 6785 | A coding exception was thrown and uncaught in a Task. 05:20:34 INFO - PID 6785 | 05:20:34 ERROR - PID 6785 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:20:34 INFO - PID 6785 | Full stack: 05:20:34 INFO - PID 6785 | ************************* 05:21:53 INFO - PID 6785 | Cycle 1(1): loaded http://localhost:59904/tests/dromaeo/cssquery-ext.html (next: http://localhost:59904/tests/dromaeo/cssquery-jquery.html) 05:21:53 INFO - PID 6785 | RSS: Main: 368115712 05:21:53 INFO - PID 6785 | 05:24:56 INFO - PID 6785 | Cycle 1(1): loaded http://localhost:59904/tests/dromaeo/cssquery-jquery.html (next: http://localhost:59904/tests/dromaeo/cssquery-mootools.html) 05:24:56 INFO - PID 6785 | RSS: Main: 355516416 05:24:56 INFO - PID 6785 | 05:27:59 INFO - PID 6785 | Cycle 1(1): loaded http://localhost:59904/tests/dromaeo/cssquery-mootools.html (next: http://localhost:59904/tests/dromaeo/cssquery-prototype.html) 05:27:59 INFO - PID 6785 | RSS: Main: 334151680 05:27:59 INFO - PID 6785 | 05:31:03 INFO - PID 6785 | Cycle 1(1): loaded http://localhost:59904/tests/dromaeo/cssquery-prototype.html (next: http://localhost:59904/tests/dromaeo/cssquery-yui.html) 05:31:04 INFO - PID 6785 | RSS: Main: 341118976 05:31:04 INFO - PID 6785 | 05:34:08 INFO - PID 6785 | Cycle 1(1): loaded http://localhost:59904/tests/dromaeo/cssquery-yui.html (next: http://localhost:59904/tests/dromaeo/cssquery-dojo.html) 05:34:08 INFO - PID 6785 | RSS: Main: 479617024 05:34:08 INFO - PID 6785 | 05:34:08 INFO - PID 6785 | __start_tp_report 05:34:08 INFO - PID 6785 | _x_x_mozilla_page_load 05:34:08 INFO - PID 6785 | _x_x_mozilla_page_load_details 05:34:08 INFO - PID 6785 | |i|pagename|runs| 05:34:08 INFO - PID 6785 | |0;dojo.html;3096.396202740465;3334.2497937963944;3351.8826841060536;3368.4778859276807;3376.4260075787115;5709.628874123179;5817.941820581793;5958.433948774859;5973.850653733659;5990.341062483123;4655.697379670319;5829.387914269004;5887.264091988502;5929.140274660161;5966.582339236255;4435.955640443586;5116.283720279164;5222.112240919053;5231.503007214308;5245.029669511134;5336.332958380202;5352.652077614943;5354.705491197982;5355.3305836770405;5358.490943360394;5192.273081768555;5248.107821670325;5266.973665131688;5277.525022747952;5312.096943519611;5264.131418315973;5316.521513063843;5322.281491998569;5367.838964831061;5389.245505629215;5098.515641014098;5252.921206181873;5255.264263003144;5266.789328426858;5292.285541451894;5074.5432911037815;5867.735951882176;5893.911591326134;5898.292204935436;5901.852453688649;6183.7835675751585;6197.907031394533;6209.937900620981;6218.875622487525;6245.375462453764;4923;6266.373362663743;6318.083877837734;6335.271443783978;6358.268799088118;5801.158831969383;5907.556933230025;6033.396660333975;6041.72812223451;6045.637261764308;6199.845003874939;6252.531060170505;6277.089821975879;6469.320721324288;6470.514711396664;6183.288921773964;6198.690065496708;6218.9378106219265;6222.097795819581;6229.065640154013;6275.497960163176;6278.152449419361;6287.465565426898;6295.874082518324;6310.52671049664;6080.513558915364;6185.226846644169;6224.719887605069;6239.344868788802;6240.937590624127;6218.533609979269;6220.942439785247;6223.937760622336;6224.906626400608;6241.625502469867;5045;5085.440601533828;5095.388553373545;5103.2855400244;5125.205593133071;4451.109778044404;4491.595756381941;4505.61702255312;4536.752393091926;4540.682152249311;5853.88292234153;5890.8821823563285;5903.2325797646035;5966.940330596639;6018.398160183947;6207.534434917309;6238.157848690459;6263.185785847811;6268.905966410507;6271.184745983084;5990.011648078105;6003.429674180946;6006.849828754316;6026.5825994858615;6071.423214794588;5441.646292990943;5503.752331145108;5577.330720313507;5581.413951535112;5591.41290164535;5619.269494965628;5793.246877905845;6324.399182077787;6390.9041364378645;6454.128692626436;6192.133101365903;6195.256569211723;6247.3440288769025;6259.1550140730415;6296.212973378328;6314.431701146918;6410.294867564658;6484.448821850196;6509.544331896722;6542.313057128933;6231.875362492816;6237.563370564017;6241.438270555672;6243.37566243372;6246.312905580474;6175.629462232101;6215.409536094064;6246.937530624636;6278.4035516625845;6305.747770089145;6106.551676171979;6112.65546444155;6138.539609529393;6138.570300078952;6143.784967526115;5968.343482217039;6111.449969502766;6116.609690437491;6121.270068921507;6121.331035925228;5432.668996095982;6052.213212282375;6117.907126107068;6136.6722581676495;6149.600275982047;5942.554308426972;6227.377262273736;6234.15838861766;6236.968815155895;6244.469220116341;5817.563682723728;6114.755409783559;6122.632642041492;6125.418085281891;6128.785492507741 05:34:08 INFO - PID 6785 | |1;ext.html;774.6320497763561;796.8366484870602;864.1444969480217;876.9780755481112;877.1623099939559;35807.641923580755;36422.45366319504;36556;36728.44907326386;36763.08092297694;37795.433068504;38154.809225953904;38159;38182;38248.23503529928;7182.102237220348;9126.726198214064;9340.813183736322;9341.346105772598;9353;7254.129504459446;10532.526036328345;10781;10788.298760580576;10795.08241799448;10870.347779133237;10957.287776294555;11104.500297486633;11106.666799996014;11134.053605443547;7181.245969173266;10978.12175026;11037.227394082378;11055.834162487568;11061.668149955514;7246.855062898765;7259.201487836386;7341.632918354115;7343.926560734378;10348.22388320879;36738;37116.44325335122;38232.80883595592;38256.80871595624;38274.425883611766;3531.699805516534;3542.1498840278146;3561.893143205708;3606.2246616977213;3706.499622550948;25735;27774.583381249297;27795;28657.853685852748;28918.096057032242;3111.284404586935;3120.0795765249304;3140.5132204508336;3157.700018498239;3221.6778322167597;341764;342797.9999999975;343605;343618;343717;32917.835410823274;39387.212255754726;39532.011699707735;50922.49077509252;50967.49032509702;48925.51074489281;49555.50444495509;49641.29842471292;49753;49807.25289120666;13923.860761392256;14003.71992560143;14014.579562613138;14019.579412617637;14022.859771402156;11400;11411.144164187719;11411.60059397917;11412.375153714525;11416.65750027484;12277.75444491123;12358.011359091432;12580.81128783069;12591.307478088609;12730.554430594884;4661.650376221797;5004.3494345734825;5226.189940559219;5238.973805131026;5249.606279529051;1004.5278719002057;1013.6654903881702;1017.5115944346755;1018.6485662446444;1035.9223058270659;15593.922030390002;15615.219239038002;15885;15894.046357218604;16077.598060048358;1095.5289225633055;1100.2408338246585;1101.218135124055;1107.241539545414;1119.1438549509633;7909.231768880961;7910.762677119696;7910.813377993232;8071.152528984489;8102.959485202537;390219;390803;391093.0445347812;391307.08692913275;391791.08208917547;54494.72752636211;54783.726081369336;54789;54875;54883;1371.3828777050367;1406.1141480866988;1431.5562175725768;1431.9713605728036;1446.992765036168;13082.542111026069;13873.890088793074;15573.299201535732;15734.68530629358;15770.211489425712;44264.55735442604;44397;44401.77799110984;44492;44577.777111114236;410341;411165;411774;412286;412676;23513;24022.51954960926;28647.14058578246;30460.695393045786;33174.33651326912;37867.62132378641;37893.67372141962;38129.23741525099;38552;40914.79542602387;34024;34186.14534636654;34322.65677343195;34959.65040349666;35426;33835.323293534486;34190.97427077092;34803.47794783131;34959.30081398409;35081.64918350784;34733.30533389268;35015.89904605732;35382.646173537934;35419.468707969914;35511.82244088763;28200.576991345555;30393.392132157674;30403;30488.499908316477;30521.54217686781;20216.898915505328;22640.320790376314;23059.6541051881;23580;23615.881920590287 05:34:08 INFO - PID 6785 | |2;jquery.html;401.34780980906027;407.49267162382836;417.60327688695736;421.11565712004796;431.3766607252521;19541.609167816634;20452.795472045276;21280;21407.785922140774;21453.57092858142;21314.786852131474;21327.25354612589;21582.92085395732;21677;21852.562948741055;6394.2966273709735;6828.419584335313;6832.726690932357;6837.076994605739;6841.315868413169;6394;6587.209534855824;6595.868082638344;6662.333766623347;6663.766768163116;6380.585261957981;6639.302873198317;6675.799726008203;6677.332266773308;6712.295209003058;6578.736850525973;6685.899711504331;6736.629485378302;6739.123913891162;6749.257581666037;6235.968820155916;6323.177986861679;6408.198975128109;6431.781035542777;6544.770933017369;26070.608940865903;26116.608250876063;26150.953961841504;26159.476810463682;26461.867690661617;2832.306085009186;2835.7306055924655;2879.5680647902773;2925.9268518287;2929.162396209316;15366.539003829903;15872.285747141406;15992.040477571383;16269.430569929995;16343.59141021484;1749.6063385738235;1910.3027395000863;1961.4704029911986;1969.1926310212743;2001.4195883193856;94386.11227775474;99815;141676;143825.5617443833;160770;17308.144156214083;18887.811121888604;20673;20970.37088887336;21078.262260821106;27360.58959115615;33871.83064084713;33977.83011084929;33990.32019359599;34054.31891362159;9989.850152247722;10159.949200253952;10337.121344685786;10352;10526.000029997138;6881.965590172117;6907.34380233877;7933.246341597539;8564.700235491728;8564.914350856536;9453.397657062931;9772.511374431393;9963.850542241873;9970.351927124713;9976.501174941224;3410.7271418286477;3898.3567711327314;3962.6829853611644;3992.6461772111566;4006.759594424344;812.7846120777998;915.6219889066912;929.693201243588;931.380631879806;931.5063016601213;22117.66823497649;22605.547889042457;22672.659910101363;22678.886605566866;22733.772662273495;924.2744445610164;940.586142097475;953.9809203815885;957.6696039866235;959.5586030425943;11151.776964460665;11488.253263537843;11576.594819181288;11729.41352932367;11730.237534560227;612143;686283;690998;695894;714898;161529;163022;165589.17205413897;167285;167414;1205.5358686905604;1242.8197911302811;1249.5564074753513;1311.7442098790643;1313.6124843171287;18865.622687545896;19960.654431357154;20183.724283839878;20859.269925552533;20865.58268834645;63846.3615363859;64754.35245647483;65078;65080;65699.68600627864;49931.25103123529;58868.705656471444;82295;85569.57215213885;87565.81085472915;8939.776505587412;10354.948225259126;11833.526658933546;12116.515339386326;12175.33035683046;13249;13250.554855737384;13557.661058473617;13768.586942391745;13798.586042418743;11393.72735224291;11706.297622142698;11879.406029698308;11891;11923.284602923852;11210.551577937118;11340.659780206606;11454.198206125491;11572.18994670365;11710.590129345432;11462;11622.128340374675;11802.645920622395;11856.585019524275;11970.22193557416;11520.83177126297;11630.6510804676;11964;11970.22193557416;12007.699807504532;11427.085833133495;11427.971482566276;11778.293302401884;11786.76426471483;11883.405829708652 05:34:08 INFO - PID 6785 | |3;mootools.html;1407.9718405631888;1521.6043828604566;1530.6249968757656;1577.5740550051487;1586.45267382753;10534.839548135558;11023.283486573388;11033.062189713874;11033.951774581403;11043.895610438962;8865.379423440361;10310.690679279614;11075;11085.722856928582;11087.445627718622;2328.359701082199;2363.846349987254;2363.858168509886;2365.9290221293304;2369.07606033647;2310.6187479065934;2329.8252631052655;2357.799587035104;2359.681443005198;2361.669366288721;2015.425603702945;2317.177402022283;2333.3466629343725;2337.357226762637;2343.906243750248;2285.691431656738;2294.724633044037;2303.28598134578;2308.5036717105904;2312.0289478418936;2257.5033492631596;2315.4211447138214;2317.188983855654;2320.709911261092;2321.6401457774073;9398.718038458857;11017.394043327613;11168.441577921072;11172.441377931153;11200.607978720787;5744.736158045223;5985.042393217108;5993;5997.550183736237;6000.909986350208;2890.0318393338257;3478.3912815257227;3500.2812639419703;3572.821358932043;3663.139162296858;1135.477680267078;1154.0825044089968;1198.3528894397016;1215.835862158606;1233.5867484392738;12603.243805371707;12981.935090324583;13008.154469959421;13017.08880378374;15106.413826548163;4540.88647783808;4689.155951928686;4691.014886873726;4704.529547045337;4704.741239231875;11574.363410012362;11578.305301681758;11582.536698532133;11601.593944211912;11604.30374177552;4881.292212629149;5076.390833100052;5647.435256474319;5826.446487583673;5852.678102704307;4516.796744146522;5241.344831896013;5350.117230656898;5356.009138309425;5362.758675859595;3349.1961929136833;3812.2947254757405;3838.27072856162;3911.882643520699;3942.329803933338;998.9100980911753;1022.6574097677361;1034.7206254311293;1035.2701345551368;1037.258360272409;755.467395486181;936.4708939449189;937.8452555328295;948.6964171465203;980.3725615606018;6020.759169633166;6103.572749907553;6586.769463068769;6607.339266073451;6754.223264324567;962.6967505235829;995.4972738766876;1004.829179039565;1033.1734612310122;1044.0446991003298;3336.382769187708;3606.5852426971232;4151.14901445203;4309;4325.502567204749;13032.41354139066;13516.662083447796;13527.45890164402;13551.186928784304;13555.254461004542;13199.274039927896;13363.866361336262;13412.329383530785;13413.463461461432;13443.462261509625;7426.74006409773;9208.12522810332;9456.196223321094;9462.57418416159;9811.558479868423;6568.80293591193;6570.868582628416;6755.459563234831;6780.220274668279;6787.592744435349;11740.823887641522;12022.63932082039;12070;12204.75590488203;12226.388680566113;11290.717732056764;12217.328046957502;12523.74952500963;12551.87448125507;12703.42834572465;8915.286777057949;9132;9282.72151835446;9283.071692830663;9289.76775580589;10029.949850250701;10046.497675116361;10243.846342304721;10288.074073333435;10292.433916134385;7778;9145;9178;9267.67563135287;9300.255979521757;8923.286137108886;8957.686480973396;9040.186383225278;9124.490765039667;9127.497987610745;7568.772936811904;7807.375409967075;7813.9218607815465;7928.7621371358955;7930.722424715107;5723.141528770718;5865.384134665969;5870.735816888165;5873.3832947539895;5950.910736338872;5974.9370428109305;5989.580729348903;5999.1601175836295;6018.307894592178;6029.065494848305 05:34:08 INFO - PID 6785 | |4;prototype.html;357.6173494361033;382.73208753872296;383.5186840515153;386.63463027439064;392.51328352842467;5160.793568257265;5825.854353641161;5916.467517923386;5942.2869255689375;5973.566344077422;5596.103409516673;5685.8578535536635;5754.884902301951;5795.71021448928;5796.8260952171395;4510.797014134372;4532.66005049621;4536.432945881765;4576.771161441931;4585;3838.7715930902123;4003.359462486003;4377.927407785097;4560.061973661197;4591.783177457976;3817.9045523861846;4400.669949753766;4484.798184081707;4547.18150732868;4772.021735544223;4490.910181796378;4491.528389519119;4492;4500.189965806154;4536.206163921301;3361.4957756336744;3983.3626619740703;3986.521617405901;3996.300647386696;4023.939640905389;5037.798488060474;5407.432219616923;5728.3126024876865;5737.110747834093;5749.683767392792;5308.973455132699;5324.1747529133045;5324.227986941872;5328.6802791832615;5336.226247194174;6167.383261673796;6230.2523697156175;6260.812175634738;6278.4035516625845;6278.843028924313;3763.5483741951143;3975.6421922026866;4082;4325.956740432587;4430.091831174602;5509.586780991402;6324.494040476797;6541.28045914949;6580.901286480706;6596.30738772422;4672.532746725368;5411.512963833274;5623.6906970116215;5626.493615574536;5645.887082258332;5521.806736764194;5553.007796143732;5764.596478246566;5768.7980920668415;5847.8245652630485;4962.702237865739;5904.166000319785;5971.4327138921735;6016.308124565643;6025.78909738157;6366.713497892606;6426.4216220540375;6444.486650206423;6469.344820176585;6471.255805582324;1949.9762624622188;1978.8120128587761;1985.463924740312;1993.2126809910005;2007.7992200779804;1286.5625687266374;1554.3782487005062;1557.1202270717008;1575.5115914066675;1589.6105454163803;5041.6722913010535;5559.748301937721;6018.608790428608;6040.214772079689;6045;6318.629354199611;6605.801825945229;6620.966895165493;6625.734970601122;6639.86720265592;5806.738696758572;5948.762049518057;6004.3395226525045;6010.579259451883;6045;3103.844807759648;3423.2297733010373;3459.515667806509;3465.9480107798404;3469.1847415857255;6222.844428889223;6286.088517164985;6471.385218404244;6636.170478690164;6827.351401616937;6001.609895356875;6323.336049714806;6342.304520578736;6722.932770672329;6742.348124709478;6529.498215410482;6701.800834228222;6793.286704895915;6798.164495586164;6821.908494640834;5097.745112744274;6501.44737697301;6517.608943463408;6547;6609.867802644017;5013.323201367769;6082.574219804571;6313.210848643919;6354.745810167727;6474.70863811139;6024.186734790747;6051.819895120585;6746.089277947611;6786.932130678828;6839.2818754032105;5394.244805727123;5501.944980550144;5582.581306402118;5609.298837645294;5627.831165065055;5469.781208751605;6519.4132528072705;6530.510211734044;6548.0832683425315;6555.787179371831;5316.441773613715;6017.849553761191;6336.303006669171;6347.619142851444;6357.205349331333;5529.30883639545;5714.5999780015;5763.769449221984;6236.812895613139;6336.809895703136;5932.911006334822;6216.160818289473;6233.844153896008;6251.156093927261;6277.748890044347;4770.952290477051;5863.736131874161;6273.215848018997;6358.895460358108;6387.297397286202;4987.426445958761;5173.767180476812;6073.930466587309;6147.262328520606;6207.565470417208 05:34:08 INFO - PID 6785 | |5;yui.html;684.6029303004257;741.336503829073;790.3400660448525;829.85062688716;830.8299376381824;14938.178400187999;15537.300821463034;15551.144687042208;15567.377304907805;15592.064476131425;14510.056846304982;14572.344244508997;14733.92633036836;14757.631059223524;14825;924.8843894513169;943.1935694980796;947.6304241345881;948.1135138645354;949.4588084791671;940.6848705683605;945.4469135555709;963.9469829159393;970.6020531582053;970.8252514547379;1022.166933948833;1022.3508072374021;1024.6618615856748;1024.6874703215517;1025.1593693171603;1017.2929813779426;1018.0989824005808;1018.383877753963;1020.2654089055868;1020.3724709303799;754.6340025087828;757.2200633347661;758.0789340950771;759.9886001709979;760.0575286644521;15606.921965390215;15925.28336224861;15970;16203.432879849266;16471.846970712057;14610.123392596372;14742.557723268212;14855.628609284746;14893.180875051868;15587.532374028797;11300.491477883434;11523.11687278017;11626.244294120856;11681.415929203506;12271.447784849703;3712.9071773205615;3742.0943416832883;3796.6013568575454;3870.4774855394444;3881;106958.86082278311;109781.9999999992;115216;115618.26572601417;120083.39958300239;11499.827502587468;11616.477258523386;11789.88210117905;11922.463489142836;12065.396730163457;25120.497590048097;25189.496210075697;25201.62197567038;25220.117295894557;25243.62134567983;7080.681369338392;7239.877818938073;7509.061367329084;7602.733904313433;7716.2283771623515;4146.274401979642;4159.833606655699;4269.18885411777;4525.773711314421;4563.863084107482;3391.1522119470133;3443.9311213775586;3480.0777793884135;3482.390581648252;3482.7562070655317;531.7261610270714;633.6356594957917;635.1520719838975;642.2229102785589;642.6304874697067;492.8546078906731;602.254236615476;609.436271448908;646.4149944300416;647.799182253503;8755.76495901024;9117.908820911705;10018.39889606626;10032.44821534808;10286.27996040285;553.8120731031914;568.590614757374;584.3134317177299;629.7292164369366;701.6912558474255;4255.595718406808;4802.591779698765;4806.2310030394965;4826.396700412449;4859.465458799529;97131;97440.51279743556;98925;100144.49783253256;101891.47162792564;47762;70658.64670676614;72222.27777722261;83345.58327208325;85440.71838922422;67202.3279767196;68621.65689171522;69593.65203173952;69665.30334696689;70355.64822175856;10487.685369438928;10564.735881603021;10826.51280692355;10957.452127393757;10991.175661825235;34598.481022785185;47914;50181;50502;52005.7399712999;70197.29802702111;70502;72415.27584724085;72873.6356318215;73268.26731732614;11638.53445862156;13390.933045335101;13469.057165998678;13843.169409835442;14225.217613031382;14294.428222870969;14470.204138772047;14740.115593064022;14856.777148343;15015.399384024953;13546.729065418833;13876.444942202603;13879.653008674864;13913.234772087633;14175.574732758034;13440.462381505022;13464.798028029783;13625;14069.718605628035;14173.078749881224;13165.736685266433;13937.930310348384;13993.860061399255;14146.504872329831;14149.504767333094;11053.557857685602;11112.9838197968;11187.216894817284;11359.148063895076;12473.750524989631;9769.85345219808;9873.605055797974;11281.21031527785;11291.774164516828;11307.208495405572 05:34:08 INFO - PID 6785 | __end_tp_report 05:34:08 INFO - PID 6785 | __start_cc_report 05:34:08 INFO - PID 6785 | _x_x_mozilla_cycle_collect,2183 05:34:08 INFO - PID 6785 | __end_cc_report 05:34:08 INFO - PID 6785 | __startTimestamp1490013248494__endTimestamp 05:34:08 INFO - PID 6785 | 05:34:08 INFO - PID 6785 | ------- Summary: start ------- 05:34:08 INFO - PID 6785 | Number of tests: 6 05:34:08 INFO - PID 6785 | 05:34:08 INFO - PID 6785 | [#0] dojo.html Cycles:165 Average:5797.84 Median:6071.42 stddev:659.44 (10.9%) stddev-sans-first:626.48 05:34:08 INFO - PID 6785 | Values: 3096.4 3334.2 3351.9 3368.5 3376.4 5709.6 5817.9 5958.4 5973.9 5990.3 4655.7 5829.4 5887.3 5929.1 5966.6 4436.0 5116.3 5222.1 5231.5 5245.0 5336.3 5352.7 5354.7 5355.3 5358.5 5192.3 5248.1 5267.0 5277.5 5312.1 5264.1 5316.5 5322.3 5367.8 5389.2 5098.5 5252.9 5255.3 5266.8 5292.3 5074.5 5867.7 5893.9 5898.3 5901.9 6183.8 6197.9 6209.9 6218.9 6245.4 4923.0 6266.4 6318.1 6335.3 6358.3 5801.2 5907.6 6033.4 6041.7 6045.6 6199.8 6252.5 6277.1 6469.3 6470.5 6183.3 6198.7 6218.9 6222.1 6229.1 6275.5 6278.2 6287.5 6295.9 6310.5 6080.5 6185.2 6224.7 6239.3 6240.9 6218.5 6220.9 6223.9 6224.9 6241.6 5045.0 5085.4 5095.4 5103.3 5125.2 4451.1 4491.6 4505.6 4536.8 4540.7 5853.9 5890.9 5903.2 5966.9 6018.4 6207.5 6238.2 6263.2 6268.9 6271.2 5990.0 6003.4 6006.8 6026.6 6071.4 5441.6 5503.8 5577.3 5581.4 5591.4 5619.3 5793.2 6324.4 6390.9 6454.1 6192.1 6195.3 6247.3 6259.2 6296.2 6314.4 6410.3 6484.4 6509.5 6542.3 6231.9 6237.6 6241.4 6243.4 6246.3 6175.6 6215.4 6246.9 6278.4 6305.7 6106.6 6112.7 6138.5 6138.6 6143.8 5968.3 6111.4 6116.6 6121.3 6121.3 5432.7 6052.2 6117.9 6136.7 6149.6 5942.6 6227.4 6234.2 6237.0 6244.5 5817.6 6114.8 6122.6 6125.4 6128.8 05:34:08 INFO - PID 6785 | 05:34:08 INFO - PID 6785 | [#1] ext.html Cycles:180 Average:51160.35 Median:34768.39 stddev:101528.73 (292.0%) stddev-sans-first:101743.07 05:34:08 INFO - PID 6785 | Values: 774.6 796.8 864.1 877.0 877.2 35807.6 36422.5 36556.0 36728.4 36763.1 37795.4 38154.8 38159.0 38182.0 38248.2 7182.1 9126.7 9340.8 9341.3 9353.0 7254.1 10532.5 10781.0 10788.3 10795.1 10870.3 10957.3 11104.5 11106.7 11134.1 7181.2 10978.1 11037.2 11055.8 11061.7 7246.9 7259.2 7341.6 7343.9 10348.2 36738.0 37116.4 38232.8 38256.8 38274.4 3531.7 3542.1 3561.9 3606.2 3706.5 25735.0 27774.6 27795.0 28657.9 28918.1 3111.3 3120.1 3140.5 3157.7 3221.7 341764.0 342798.0 343605.0 343618.0 343717.0 32917.8 39387.2 39532.0 50922.5 50967.5 48925.5 49555.5 49641.3 49753.0 49807.3 13923.9 14003.7 14014.6 14019.6 14022.9 11400.0 11411.1 11411.6 11412.4 11416.7 12277.8 12358.0 12580.8 12591.3 12730.6 4661.7 5004.3 5226.2 5239.0 5249.6 1004.5 1013.7 1017.5 1018.6 1035.9 15593.9 15615.2 15885.0 15894.0 16077.6 1095.5 1100.2 1101.2 1107.2 1119.1 7909.2 7910.8 7910.8 8071.2 8103.0 390219.0 390803.0 391093.0 391307.1 391791.1 54494.7 54783.7 54789.0 54875.0 54883.0 1371.4 1406.1 1431.6 1432.0 1447.0 13082.5 13873.9 15573.3 15734.7 15770.2 44264.6 44397.0 44401.8 44492.0 44577.8 410341.0 411165.0 411774.0 412286.0 412676.0 23513.0 24022.5 28647.1 30460.7 33174.3 37867.6 37893.7 38129.2 38552.0 40914.8 34024.0 34186.1 34322.7 34959.7 35426.0 33835.3 34191.0 34803.5 34959.3 35081.6 34733.3 35015.9 35382.6 35419.5 35511.8 28200.6 30393.4 30403.0 30488.5 30521.5 20216.9 22640.3 23059.7 23580.0 23615.9 05:34:08 INFO - PID 6785 | 05:34:08 INFO - PID 6785 | [#2] jquery.html Cycles:180 Average:40505.41 Median:24402.19 stddev:113915.77 (466.8%) stddev-sans-first:114195.54 05:34:08 INFO - PID 6785 | Values: 401.3 407.5 417.6 421.1 431.4 19541.6 20452.8 21280.0 21407.8 21453.6 21314.8 21327.3 21582.9 21677.0 21852.6 6394.3 6828.4 6832.7 6837.1 6841.3 6394.0 6587.2 6595.9 6662.3 6663.8 6380.6 6639.3 6675.8 6677.3 6712.3 6578.7 6685.9 6736.6 6739.1 6749.3 6236.0 6323.2 6408.2 6431.8 6544.8 26070.6 26116.6 26151.0 26159.5 26461.9 2832.3 2835.7 2879.6 2925.9 2929.2 15366.5 15872.3 15992.0 16269.4 16343.6 1749.6 1910.3 1961.5 1969.2 2001.4 94386.1 99815.0 141676.0 143825.6 160770.0 17308.1 18887.8 20673.0 20970.4 21078.3 27360.6 33871.8 33977.8 33990.3 34054.3 9989.9 10159.9 10337.1 10352.0 10526.0 6882.0 6907.3 7933.2 8564.7 8564.9 9453.4 9772.5 9963.9 9970.4 9976.5 3410.7 3898.4 3962.7 3992.6 4006.8 812.8 915.6 929.7 931.4 931.5 22117.7 22605.5 22672.7 22678.9 22733.8 924.3 940.6 954.0 957.7 959.6 11151.8 11488.3 11576.6 11729.4 11730.2 612143.0 686283.0 690998.0 695894.0 714898.0 161529.0 163022.0 165589.2 167285.0 167414.0 1205.5 1242.8 1249.6 1311.7 1313.6 18865.6 19960.7 20183.7 20859.3 20865.6 63846.4 64754.4 65078.0 65080.0 65699.7 49931.3 58868.7 82295.0 85569.6 87565.8 8939.8 10354.9 11833.5 12116.5 12175.3 13249.0 13250.6 13557.7 13768.6 13798.6 11393.7 11706.3 11879.4 11891.0 11923.3 11210.6 11340.7 11454.2 11572.2 11710.6 11462.0 11622.1 11802.6 11856.6 11970.2 11520.8 11630.7 11964.0 11970.2 12007.7 11427.1 11428.0 11778.3 11786.8 11883.4 05:34:08 INFO - PID 6785 | 05:34:08 INFO - PID 6785 | [#3] mootools.html Cycles:180 Average:6584.45 Median:3113.21 stddev:4072.93 (130.8%) stddev-sans-first:4065.78 05:34:08 INFO - PID 6785 | Values: 1408.0 1521.6 1530.6 1577.6 1586.5 10534.8 11023.3 11033.1 11034.0 11043.9 8865.4 10310.7 11075.0 11085.7 11087.4 2328.4 2363.8 2363.9 2365.9 2369.1 2310.6 2329.8 2357.8 2359.7 2361.7 2015.4 2317.2 2333.3 2337.4 2343.9 2285.7 2294.7 2303.3 2308.5 2312.0 2257.5 2315.4 2317.2 2320.7 2321.6 9398.7 11017.4 11168.4 11172.4 11200.6 5744.7 5985.0 5993.0 5997.6 6000.9 2890.0 3478.4 3500.3 3572.8 3663.1 1135.5 1154.1 1198.4 1215.8 1233.6 12603.2 12981.9 13008.2 13017.1 15106.4 4540.9 4689.2 4691.0 4704.5 4704.7 11574.4 11578.3 11582.5 11601.6 11604.3 4881.3 5076.4 5647.4 5826.4 5852.7 4516.8 5241.3 5350.1 5356.0 5362.8 3349.2 3812.3 3838.3 3911.9 3942.3 998.9 1022.7 1034.7 1035.3 1037.3 755.5 936.5 937.8 948.7 980.4 6020.8 6103.6 6586.8 6607.3 6754.2 962.7 995.5 1004.8 1033.2 1044.0 3336.4 3606.6 4151.1 4309.0 4325.5 13032.4 13516.7 13527.5 13551.2 13555.3 13199.3 13363.9 13412.3 13413.5 13443.5 7426.7 9208.1 9456.2 9462.6 9811.6 6568.8 6570.9 6755.5 6780.2 6787.6 11740.8 12022.6 12070.0 12204.8 12226.4 11290.7 12217.3 12523.7 12551.9 12703.4 8915.3 9132.0 9282.7 9283.1 9289.8 10029.9 10046.5 10243.8 10288.1 10292.4 7778.0 9145.0 9178.0 9267.7 9300.3 8923.3 8957.7 9040.2 9124.5 9127.5 7568.8 7807.4 7813.9 7928.8 7930.7 5723.1 5865.4 5870.7 5873.4 5950.9 5974.9 5989.6 5999.2 6018.3 6029.1 05:34:08 INFO - PID 6785 | 05:34:08 INFO - PID 6785 | [#4] prototype.html Cycles:180 Average:5265.77 Median:5766.70 stddev:1496.77 (26.0%) stddev-sans-first:1454.92 05:34:08 INFO - PID 6785 | Values: 357.6 382.7 383.5 386.6 392.5 5160.8 5825.9 5916.5 5942.3 5973.6 5596.1 5685.9 5754.9 5795.7 5796.8 4510.8 4532.7 4536.4 4576.8 4585.0 3838.8 4003.4 4377.9 4560.1 4591.8 3817.9 4400.7 4484.8 4547.2 4772.0 4490.9 4491.5 4492.0 4500.2 4536.2 3361.5 3983.4 3986.5 3996.3 4023.9 5037.8 5407.4 5728.3 5737.1 5749.7 5309.0 5324.2 5324.2 5328.7 5336.2 6167.4 6230.3 6260.8 6278.4 6278.8 3763.5 3975.6 4082.0 4326.0 4430.1 5509.6 6324.5 6541.3 6580.9 6596.3 4672.5 5411.5 5623.7 5626.5 5645.9 5521.8 5553.0 5764.6 5768.8 5847.8 4962.7 5904.2 5971.4 6016.3 6025.8 6366.7 6426.4 6444.5 6469.3 6471.3 1950.0 1978.8 1985.5 1993.2 2007.8 1286.6 1554.4 1557.1 1575.5 1589.6 5041.7 5559.7 6018.6 6040.2 6045.0 6318.6 6605.8 6621.0 6625.7 6639.9 5806.7 5948.8 6004.3 6010.6 6045.0 3103.8 3423.2 3459.5 3465.9 3469.2 6222.8 6286.1 6471.4 6636.2 6827.4 6001.6 6323.3 6342.3 6722.9 6742.3 6529.5 6701.8 6793.3 6798.2 6821.9 5097.7 6501.4 6517.6 6547.0 6609.9 5013.3 6082.6 6313.2 6354.7 6474.7 6024.2 6051.8 6746.1 6786.9 6839.3 5394.2 5501.9 5582.6 5609.3 5627.8 5469.8 6519.4 6530.5 6548.1 6555.8 5316.4 6017.8 6336.3 6347.6 6357.2 5529.3 5714.6 5763.8 6236.8 6336.8 5932.9 6216.2 6233.8 6251.2 6277.7 4771.0 5863.7 6273.2 6358.9 6387.3 4987.4 5173.8 6073.9 6147.3 6207.6 05:34:08 INFO - PID 6785 | 05:34:08 INFO - PID 6785 | [#5] yui.html Cycles:180 Average:20148.03 Median:25210.87 stddev:28490.00 (113.0%) stddev-sans-first:28532.44 05:34:08 INFO - PID 6785 | Values: 684.6 741.3 790.3 829.9 830.8 14938.2 15537.3 15551.1 15567.4 15592.1 14510.1 14572.3 14733.9 14757.6 14825.0 924.9 943.2 947.6 948.1 949.5 940.7 945.4 963.9 970.6 970.8 1022.2 1022.4 1024.7 1024.7 1025.2 1017.3 1018.1 1018.4 1020.3 1020.4 754.6 757.2 758.1 760.0 760.1 15606.9 15925.3 15970.0 16203.4 16471.8 14610.1 14742.6 14855.6 14893.2 15587.5 11300.5 11523.1 11626.2 11681.4 12271.4 3712.9 3742.1 3796.6 3870.5 3881.0 106958.9 109782.0 115216.0 115618.3 120083.4 11499.8 11616.5 11789.9 11922.5 12065.4 25120.5 25189.5 25201.6 25220.1 25243.6 7080.7 7239.9 7509.1 7602.7 7716.2 4146.3 4159.8 4269.2 4525.8 4563.9 3391.2 3443.9 3480.1 3482.4 3482.8 531.7 633.6 635.2 642.2 642.6 492.9 602.3 609.4 646.4 647.8 8755.8 9117.9 10018.4 10032.4 10286.3 553.8 568.6 584.3 629.7 701.7 4255.6 4802.6 4806.2 4826.4 4859.5 97131.0 97440.5 98925.0 100144.5 101891.5 47762.0 70658.6 72222.3 83345.6 85440.7 67202.3 68621.7 69593.7 69665.3 70355.6 10487.7 10564.7 10826.5 10957.5 10991.2 34598.5 47914.0 50181.0 50502.0 52005.7 70197.3 70502.0 72415.3 72873.6 73268.3 11638.5 13390.9 13469.1 13843.2 14225.2 14294.4 14470.2 14740.1 14856.8 15015.4 13546.7 13876.4 13879.7 13913.2 14175.6 13440.5 13464.8 13625.0 14069.7 14173.1 13165.7 13937.9 13993.9 14146.5 14149.5 11053.6 11113.0 11187.2 11359.1 12473.8 9769.9 9873.6 11281.2 11291.8 11307.2 05:34:08 INFO - PID 6785 | -------- Summary: end -------- 05:34:08 INFO - PID 6785 | 05:34:09 INFO - TEST-INFO | 6785: exit 0 05:34:09 INFO - TEST-OK | dromaeo_css | took 1120882ms 05:34:09 INFO - TEST-START | kraken 05:34:09 INFO - operating with platform_type : mac_ 05:34:09 INFO - Initialising browser for kraken test... 05:34:09 INFO - TEST-INFO | started process 6790 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmp_kVlf_/profile http://localhost:59904/getInfo.html) 05:34:12 INFO - PID 6790 | __metrics Screen width/height:1600/1200 05:34:12 INFO - PID 6790 | colorDepth:24 05:34:12 INFO - PID 6790 | Browser inner width/height: 1024/689 05:34:12 INFO - PID 6790 | __metrics 05:34:12 INFO - PID 6790 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:34:12 INFO - PID 6790 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:34:12 INFO - TEST-INFO | 6790: exit 0 05:34:12 INFO - Browser initialized. 05:34:12 INFO - Running cycle 1/1 for kraken test... 05:34:12 INFO - TEST-INFO | started process 6791 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/T/tmp_kVlf_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:34:25 INFO - PID 6791 | RSS: Main: 233410560 05:34:25 INFO - PID 6791 | 05:34:27 INFO - PID 6791 | Cycle 1(1): loaded http://localhost:59904/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:59904/tests/kraken/driver.html?testName=audio-beat-detection) 05:34:28 INFO - PID 6791 | RSS: Main: 284368896 05:34:28 INFO - PID 6791 | 05:34:31 INFO - PID 6791 | Cycle 1(1): loaded http://localhost:59904/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:59904/tests/kraken/driver.html?testName=audio-dft) 05:34:31 INFO - PID 6791 | RSS: Main: 285528064 05:34:31 INFO - PID 6791 | 05:34:35 INFO - PID 6791 | Cycle 1(1): loaded http://localhost:59904/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:59904/tests/kraken/driver.html?testName=audio-fft) 05:34:35 INFO - PID 6791 | RSS: Main: 377954304 05:34:35 INFO - PID 6791 | 05:34:38 INFO - PID 6791 | Cycle 1(1): loaded http://localhost:59904/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:59904/tests/kraken/driver.html?testName=audio-oscillator) 05:34:38 INFO - PID 6791 | RSS: Main: 281698304 05:34:38 INFO - PID 6791 | 05:34:40 INFO - PID 6791 | Cycle 1(1): loaded http://localhost:59904/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:59904/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:34:41 INFO - PID 6791 | RSS: Main: 284413952 05:34:41 INFO - PID 6791 | 05:34:44 INFO - PID 6791 | Cycle 1(1): loaded http://localhost:59904/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:59904/tests/kraken/driver.html?testName=imaging-darkroom) 05:34:44 INFO - PID 6791 | RSS: Main: 326148096 05:34:44 INFO - PID 6791 | 05:34:47 INFO - PID 6791 | Cycle 1(1): loaded http://localhost:59904/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:59904/tests/kraken/driver.html?testName=imaging-desaturate) 05:34:48 INFO - PID 6791 | RSS: Main: 343318528 05:34:48 INFO - PID 6791 | 05:34:51 INFO - PID 6791 | Cycle 1(1): loaded http://localhost:59904/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:59904/tests/kraken/driver.html?testName=json-parse-financial) 05:34:51 INFO - PID 6791 | RSS: Main: 358092800 05:34:51 INFO - PID 6791 | 05:34:53 INFO - PID 6791 | Cycle 1(1): loaded http://localhost:59904/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:59904/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:34:54 INFO - PID 6791 | RSS: Main: 303521792 05:34:54 INFO - PID 6791 | 05:34:56 INFO - PID 6791 | Cycle 1(1): loaded http://localhost:59904/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:59904/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:34:56 INFO - PID 6791 | RSS: Main: 306610176 05:34:56 INFO - PID 6791 | 05:34:58 INFO - PID 6791 | Cycle 1(1): loaded http://localhost:59904/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:59904/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:34:59 INFO - PID 6791 | RSS: Main: 307843072 05:34:59 INFO - PID 6791 | 05:35:02 INFO - PID 6791 | Cycle 1(1): loaded http://localhost:59904/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:59904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:35:03 INFO - PID 6791 | RSS: Main: 326307840 05:35:03 INFO - PID 6791 | 05:35:06 INFO - PID 6791 | Cycle 1(1): loaded http://localhost:59904/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:59904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:35:07 INFO - PID 6791 | RSS: Main: 320016384 05:35:07 INFO - PID 6791 | 05:35:08 INFO - PID 6791 | Cycle 1(1): loaded http://localhost:59904/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:59904/tests/kraken/driver.html?testName=ai-astar) 05:35:09 INFO - PID 6791 | RSS: Main: 381505536 05:35:09 INFO - PID 6791 | 05:35:09 INFO - PID 6791 | __start_tp_report 05:35:09 INFO - PID 6791 | _x_x_mozilla_page_load 05:35:09 INFO - PID 6791 | _x_x_mozilla_page_load_details 05:35:09 INFO - PID 6791 | |i|pagename|runs| 05:35:09 INFO - PID 6791 | |0;ai-astar;114;115;115;115;116;112;107;115;115;114 05:35:09 INFO - PID 6791 | |1;audio-beat-detection;153;112;113;150;114;112;110;96;134;112 05:35:09 INFO - PID 6791 | |2;audio-dft;185;185;187;188;186;186;181;189;186;186 05:35:09 INFO - PID 6791 | |3;audio-fft;79;60;59;113;85;68;60;60;77;59 05:35:09 INFO - PID 6791 | |4;audio-oscillator;91;70;85;69;70;68;84;70;68;85 05:35:09 INFO - PID 6791 | |5;imaging-gaussian-blur;86;86;87;86;88;87;87;85;86;86 05:35:09 INFO - PID 6791 | |6;imaging-darkroom;93;94;93;95;94;94;94;93;94;94 05:35:09 INFO - PID 6791 | |7;imaging-desaturate;87;88;87;86;85;84;86;85;86;84 05:35:09 INFO - PID 6791 | |8;json-parse-financial;65;63;63;61;63;62;63;63;61;62 05:35:09 INFO - PID 6791 | |9;json-stringify-tinderbox;57;59;67;68;64;59;74;82;84;84 05:35:09 INFO - PID 6791 | |10;stanford-crypto-aes;82;82;83;84;84;82;83;81;83;82 05:35:09 INFO - PID 6791 | |11;stanford-crypto-ccm;139;139;141;141;143;142;151;140;177;148 05:35:09 INFO - PID 6791 | |12;stanford-crypto-pbkdf2;181;177;184;189;187;180;192;234;191;183 05:35:09 INFO - PID 6791 | |13;stanford-crypto-sha256-iterative;68;67;67;67;68;69;67;68;68;68 05:35:09 INFO - PID 6791 | __end_tp_report 05:35:09 INFO - PID 6791 | __start_cc_report 05:35:09 INFO - PID 6791 | _x_x_mozilla_cycle_collect,2137 05:35:09 INFO - PID 6791 | __end_cc_report 05:35:09 INFO - PID 6791 | __startTimestamp1490013309044__endTimestamp 05:35:09 INFO - PID 6791 | 05:35:09 INFO - PID 6791 | ------- Summary: start ------- 05:35:09 INFO - PID 6791 | Number of tests: 14 05:35:09 INFO - PID 6791 | 05:35:09 INFO - PID 6791 | [#0] ai-astar Cycles:10 Average:113.80 Median:115.00 stddev:2.62 (2.3%) stddev-sans-first:2.77 05:35:09 INFO - PID 6791 | Values: 114.0 115.0 115.0 115.0 116.0 112.0 107.0 115.0 115.0 114.0 05:35:09 INFO - PID 6791 | 05:35:09 INFO - PID 6791 | [#1] audio-beat-detection Cycles:10 Average:120.60 Median:124.00 stddev:18.66 (15.0%) stddev-sans-first:15.68 05:35:09 INFO - PID 6791 | Values: 153.0 112.0 113.0 150.0 114.0 112.0 110.0 96.0 134.0 112.0 05:35:09 INFO - PID 6791 | 05:35:09 INFO - PID 6791 | [#2] audio-dft Cycles:10 Average:185.90 Median:186.00 stddev:2.13 (1.1%) stddev-sans-first:2.24 05:35:09 INFO - PID 6791 | Values: 185.0 185.0 187.0 188.0 186.0 186.0 181.0 189.0 186.0 186.0 05:35:09 INFO - PID 6791 | 05:35:09 INFO - PID 6791 | [#3] audio-fft Cycles:10 Average:72.00 Median:64.00 stddev:17.35 (27.1%) stddev-sans-first:18.22 05:35:09 INFO - PID 6791 | Values: 79.0 60.0 59.0 113.0 85.0 68.0 60.0 60.0 77.0 59.0 05:35:09 INFO - PID 6791 | 05:35:09 INFO - PID 6791 | [#4] audio-oscillator Cycles:10 Average:76.00 Median:77.00 stddev:9.04 (11.7%) stddev-sans-first:7.79 05:35:09 INFO - PID 6791 | Values: 91.0 70.0 85.0 69.0 70.0 68.0 84.0 70.0 68.0 85.0 05:35:09 INFO - PID 6791 | 05:35:09 INFO - PID 6791 | [#5] imaging-gaussian-blur Cycles:10 Average:86.40 Median:86.50 stddev:0.84 (1.0%) stddev-sans-first:0.88 05:35:09 INFO - PID 6791 | Values: 86.0 86.0 87.0 86.0 88.0 87.0 87.0 85.0 86.0 86.0 05:35:09 INFO - PID 6791 | 05:35:09 INFO - PID 6791 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.63 (0.7%) stddev-sans-first:0.60 05:35:09 INFO - PID 6791 | Values: 93.0 94.0 93.0 95.0 94.0 94.0 94.0 93.0 94.0 94.0 05:35:09 INFO - PID 6791 | 05:35:09 INFO - PID 6791 | [#7] imaging-desaturate Cycles:10 Average:85.80 Median:86.00 stddev:1.32 (1.5%) stddev-sans-first:1.32 05:35:09 INFO - PID 6791 | Values: 87.0 88.0 87.0 86.0 85.0 84.0 86.0 85.0 86.0 84.0 05:35:09 INFO - PID 6791 | 05:35:09 INFO - PID 6791 | [#8] json-parse-financial Cycles:10 Average:62.60 Median:63.00 stddev:1.17 (1.9%) stddev-sans-first:0.87 05:35:09 INFO - PID 6791 | Values: 65.0 63.0 63.0 61.0 63.0 62.0 63.0 63.0 61.0 62.0 05:35:09 INFO - PID 6791 | 05:35:09 INFO - PID 6791 | [#9] json-stringify-tinderbox Cycles:10 Average:69.80 Median:71.00 stddev:10.60 (14.9%) stddev-sans-first:10.18 05:35:09 INFO - PID 6791 | Values: 57.0 59.0 67.0 68.0 64.0 59.0 74.0 82.0 84.0 84.0 05:35:09 INFO - PID 6791 | 05:35:09 INFO - PID 6791 | [#10] stanford-crypto-aes Cycles:10 Average:82.60 Median:83.00 stddev:0.97 (1.2%) stddev-sans-first:1.00 05:35:09 INFO - PID 6791 | Values: 82.0 82.0 83.0 84.0 84.0 82.0 83.0 81.0 83.0 82.0 05:35:09 INFO - PID 6791 | 05:35:09 INFO - PID 6791 | [#11] stanford-crypto-ccm Cycles:10 Average:146.10 Median:142.50 stddev:11.54 (8.1%) stddev-sans-first:11.95 05:35:09 INFO - PID 6791 | Values: 139.0 139.0 141.0 141.0 143.0 142.0 151.0 140.0 177.0 148.0 05:35:09 INFO - PID 6791 | 05:35:09 INFO - PID 6791 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:189.80 Median:188.00 stddev:16.28 (8.7%) stddev-sans-first:16.95 05:35:09 INFO - PID 6791 | Values: 181.0 177.0 184.0 189.0 187.0 180.0 192.0 234.0 191.0 183.0 05:35:09 INFO - PID 6791 | 05:35:09 INFO - PID 6791 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.70 Median:68.00 stddev:0.67 (1.0%) stddev-sans-first:0.71 05:35:09 INFO - PID 6791 | Values: 68.0 67.0 67.0 67.0 68.0 69.0 67.0 68.0 68.0 68.0 05:35:09 INFO - PID 6791 | -------- Summary: end -------- 05:35:09 INFO - PID 6791 | 05:35:09 INFO - TEST-INFO | 6791: exit 0 05:35:10 INFO - TEST-OK | kraken | took 60767ms 05:35:10 INFO - SUITE-END | took 1181s 05:35:10 INFO - Completed test suite (00:19:41) 05:35:10 INFO - javascript benchmark 05:35:10 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7711.71666536607, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3096.396202740465, 3334.2497937963944, 3351.8826841060536, 3368.4778859276807, 3376.4260075787115, 5709.628874123179, 5817.941820581793, 5958.433948774859, 5973.850653733659, 5990.341062483123, 4655.697379670319, 5829.387914269004, 5887.264091988502, 5929.140274660161, 5966.582339236255, 4435.955640443586, 5116.283720279164, 5222.112240919053, 5231.503007214308, 5245.029669511134, 5336.332958380202, 5352.652077614943, 5354.705491197982, 5355.3305836770405, 5358.490943360394, 5192.273081768555, 5248.107821670325, 5266.973665131688, 5277.525022747952, 5312.096943519611, 5264.131418315973, 5316.521513063843, 5322.281491998569, 5367.838964831061, 5389.245505629215, 5098.515641014098, 5252.921206181873, 5255.264263003144, 5266.789328426858, 5292.285541451894, 5074.5432911037815, 5867.735951882176, 5893.911591326134, 5898.292204935436, 5901.852453688649, 6183.7835675751585, 6197.907031394533, 6209.937900620981, 6218.875622487525, 6245.375462453764, 4923.0, 6266.373362663743, 6318.083877837734, 6335.271443783978, 6358.268799088118, 5801.158831969383, 5907.556933230025, 6033.396660333975, 6041.72812223451, 6045.637261764308, 6199.845003874939, 6252.531060170505, 6277.089821975879, 6469.320721324288, 6470.514711396664, 6183.288921773964, 6198.690065496708, 6218.9378106219265, 6222.097795819581, 6229.065640154013, 6275.497960163176, 6278.152449419361, 6287.465565426898, 6295.874082518324, 6310.52671049664, 6080.513558915364, 6185.226846644169, 6224.719887605069, 6239.344868788802, 6240.937590624127, 6218.533609979269, 6220.942439785247, 6223.937760622336, 6224.906626400608, 6241.625502469867, 5045.0, 5085.440601533828, 5095.388553373545, 5103.2855400244, 5125.205593133071, 4451.109778044404, 4491.595756381941, 4505.61702255312, 4536.752393091926, 4540.682152249311, 5853.88292234153, 5890.8821823563285, 5903.2325797646035, 5966.940330596639, 6018.398160183947, 6207.534434917309, 6238.157848690459, 6263.185785847811, 6268.905966410507, 6271.184745983084, 5990.011648078105, 6003.429674180946, 6006.849828754316, 6026.5825994858615, 6071.423214794588, 5441.646292990943, 5503.752331145108, 5577.330720313507, 5581.413951535112, 5591.41290164535, 5619.269494965628, 5793.246877905845, 6324.399182077787, 6390.9041364378645, 6454.128692626436, 6192.133101365903, 6195.256569211723, 6247.3440288769025, 6259.1550140730415, 6296.212973378328, 6314.431701146918, 6410.294867564658, 6484.448821850196, 6509.544331896722, 6542.313057128933, 6231.875362492816, 6237.563370564017, 6241.438270555672, 6243.37566243372, 6246.312905580474, 6175.629462232101, 6215.409536094064, 6246.937530624636, 6278.4035516625845, 6305.747770089145, 6106.551676171979, 6112.65546444155, 6138.539609529393, 6138.570300078952, 6143.784967526115, 5968.343482217039, 6111.449969502766, 6116.609690437491, 6121.270068921507, 6121.331035925228, 5432.668996095982, 6052.213212282375, 6117.907126107068, 6136.6722581676495, 6149.600275982047, 5942.554308426972, 6227.377262273736, 6234.15838861766, 6236.968815155895, 6244.469220116341, 5817.563682723728, 6114.755409783559, 6122.632642041492, 6125.418085281891, 6128.785492507741], "value": 5755.74645276386, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [774.6320497763561, 796.8366484870602, 864.1444969480217, 876.9780755481112, 877.1623099939559, 35807.641923580755, 36422.45366319504, 36556.0, 36728.44907326386, 36763.08092297694, 37795.433068504, 38154.809225953904, 38159.0, 38182.0, 38248.23503529928, 7182.102237220348, 9126.726198214064, 9340.813183736322, 9341.346105772598, 9353.0, 7254.129504459446, 10532.526036328345, 10781.0, 10788.298760580576, 10795.08241799448, 10870.347779133237, 10957.287776294555, 11104.500297486633, 11106.666799996014, 11134.053605443547, 7181.245969173266, 10978.12175026, 11037.227394082378, 11055.834162487568, 11061.668149955514, 7246.855062898765, 7259.201487836386, 7341.632918354115, 7343.926560734378, 10348.22388320879, 36738.0, 37116.44325335122, 38232.80883595592, 38256.80871595624, 38274.425883611766, 3531.699805516534, 3542.1498840278146, 3561.893143205708, 3606.2246616977213, 3706.499622550948, 25735.0, 27774.583381249297, 27795.0, 28657.853685852748, 28918.096057032242, 3111.284404586935, 3120.0795765249304, 3140.5132204508336, 3157.700018498239, 3221.6778322167597, 341764.0, 342797.9999999975, 343605.0, 343618.0, 343717.0, 32917.835410823274, 39387.212255754726, 39532.011699707735, 50922.49077509252, 50967.49032509702, 48925.51074489281, 49555.50444495509, 49641.29842471292, 49753.0, 49807.25289120666, 13923.860761392256, 14003.71992560143, 14014.579562613138, 14019.579412617637, 14022.859771402156, 11400.0, 11411.144164187719, 11411.60059397917, 11412.375153714525, 11416.65750027484, 12277.75444491123, 12358.011359091432, 12580.81128783069, 12591.307478088609, 12730.554430594884, 4661.650376221797, 5004.3494345734825, 5226.189940559219, 5238.973805131026, 5249.606279529051, 1004.5278719002057, 1013.6654903881702, 1017.5115944346755, 1018.6485662446444, 1035.9223058270659, 15593.922030390002, 15615.219239038002, 15885.0, 15894.046357218604, 16077.598060048358, 1095.5289225633055, 1100.2408338246585, 1101.218135124055, 1107.241539545414, 1119.1438549509633, 7909.231768880961, 7910.762677119696, 7910.813377993232, 8071.152528984489, 8102.959485202537, 390219.0, 390803.0, 391093.0445347812, 391307.08692913275, 391791.08208917547, 54494.72752636211, 54783.726081369336, 54789.0, 54875.0, 54883.0, 1371.3828777050367, 1406.1141480866988, 1431.5562175725768, 1431.9713605728036, 1446.992765036168, 13082.542111026069, 13873.890088793074, 15573.299201535732, 15734.68530629358, 15770.211489425712, 44264.55735442604, 44397.0, 44401.77799110984, 44492.0, 44577.777111114236, 410341.0, 411165.0, 411774.0, 412286.0, 412676.0, 23513.0, 24022.51954960926, 28647.14058578246, 30460.695393045786, 33174.33651326912, 37867.62132378641, 37893.67372141962, 38129.23741525099, 38552.0, 40914.79542602387, 34024.0, 34186.14534636654, 34322.65677343195, 34959.65040349666, 35426.0, 33835.323293534486, 34190.97427077092, 34803.47794783131, 34959.30081398409, 35081.64918350784, 34733.30533389268, 35015.89904605732, 35382.646173537934, 35419.468707969914, 35511.82244088763, 28200.576991345555, 30393.392132157674, 30403.0, 30488.499908316477, 30521.54217686781, 20216.898915505328, 22640.320790376314, 23059.6541051881, 23580.0, 23615.881920590287], "value": 17186.69128791158, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [401.34780980906027, 407.49267162382836, 417.60327688695736, 421.11565712004796, 431.3766607252521, 19541.609167816634, 20452.795472045276, 21280.0, 21407.785922140774, 21453.57092858142, 21314.786852131474, 21327.25354612589, 21582.92085395732, 21677.0, 21852.562948741055, 6394.2966273709735, 6828.419584335313, 6832.726690932357, 6837.076994605739, 6841.315868413169, 6394.0, 6587.209534855824, 6595.868082638344, 6662.333766623347, 6663.766768163116, 6380.585261957981, 6639.302873198317, 6675.799726008203, 6677.332266773308, 6712.295209003058, 6578.736850525973, 6685.899711504331, 6736.629485378302, 6739.123913891162, 6749.257581666037, 6235.968820155916, 6323.177986861679, 6408.198975128109, 6431.781035542777, 6544.770933017369, 26070.608940865903, 26116.608250876063, 26150.953961841504, 26159.476810463682, 26461.867690661617, 2832.306085009186, 2835.7306055924655, 2879.5680647902773, 2925.9268518287, 2929.162396209316, 15366.539003829903, 15872.285747141406, 15992.040477571383, 16269.430569929995, 16343.59141021484, 1749.6063385738235, 1910.3027395000863, 1961.4704029911986, 1969.1926310212743, 2001.4195883193856, 94386.11227775474, 99815.0, 141676.0, 143825.5617443833, 160770.0, 17308.144156214083, 18887.811121888604, 20673.0, 20970.37088887336, 21078.262260821106, 27360.58959115615, 33871.83064084713, 33977.83011084929, 33990.32019359599, 34054.31891362159, 9989.850152247722, 10159.949200253952, 10337.121344685786, 10352.0, 10526.000029997138, 6881.965590172117, 6907.34380233877, 7933.246341597539, 8564.700235491728, 8564.914350856536, 9453.397657062931, 9772.511374431393, 9963.850542241873, 9970.351927124713, 9976.501174941224, 3410.7271418286477, 3898.3567711327314, 3962.6829853611644, 3992.6461772111566, 4006.759594424344, 812.7846120777998, 915.6219889066912, 929.693201243588, 931.380631879806, 931.5063016601213, 22117.66823497649, 22605.547889042457, 22672.659910101363, 22678.886605566866, 22733.772662273495, 924.2744445610164, 940.586142097475, 953.9809203815885, 957.6696039866235, 959.5586030425943, 11151.776964460665, 11488.253263537843, 11576.594819181288, 11729.41352932367, 11730.237534560227, 612143.0, 686283.0, 690998.0, 695894.0, 714898.0, 161529.0, 163022.0, 165589.17205413897, 167285.0, 167414.0, 1205.5358686905604, 1242.8197911302811, 1249.5564074753513, 1311.7442098790643, 1313.6124843171287, 18865.622687545896, 19960.654431357154, 20183.724283839878, 20859.269925552533, 20865.58268834645, 63846.3615363859, 64754.35245647483, 65078.0, 65080.0, 65699.68600627864, 49931.25103123529, 58868.705656471444, 82295.0, 85569.57215213885, 87565.81085472915, 8939.776505587412, 10354.948225259126, 11833.526658933546, 12116.515339386326, 12175.33035683046, 13249.0, 13250.554855737384, 13557.661058473617, 13768.586942391745, 13798.586042418743, 11393.72735224291, 11706.297622142698, 11879.406029698308, 11891.0, 11923.284602923852, 11210.551577937118, 11340.659780206606, 11454.198206125491, 11572.18994670365, 11710.590129345432, 11462.0, 11622.128340374675, 11802.645920622395, 11856.585019524275, 11970.22193557416, 11520.83177126297, 11630.6510804676, 11964.0, 11970.22193557416, 12007.699807504532, 11427.085833133495, 11427.971482566276, 11778.293302401884, 11786.76426471483, 11883.405829708652], "value": 11458.074099673651, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1407.9718405631888, 1521.6043828604566, 1530.6249968757656, 1577.5740550051487, 1586.45267382753, 10534.839548135558, 11023.283486573388, 11033.062189713874, 11033.951774581403, 11043.895610438962, 8865.379423440361, 10310.690679279614, 11075.0, 11085.722856928582, 11087.445627718622, 2328.359701082199, 2363.846349987254, 2363.858168509886, 2365.9290221293304, 2369.07606033647, 2310.6187479065934, 2329.8252631052655, 2357.799587035104, 2359.681443005198, 2361.669366288721, 2015.425603702945, 2317.177402022283, 2333.3466629343725, 2337.357226762637, 2343.906243750248, 2285.691431656738, 2294.724633044037, 2303.28598134578, 2308.5036717105904, 2312.0289478418936, 2257.5033492631596, 2315.4211447138214, 2317.188983855654, 2320.709911261092, 2321.6401457774073, 9398.718038458857, 11017.394043327613, 11168.441577921072, 11172.441377931153, 11200.607978720787, 5744.736158045223, 5985.042393217108, 5993.0, 5997.550183736237, 6000.909986350208, 2890.0318393338257, 3478.3912815257227, 3500.2812639419703, 3572.821358932043, 3663.139162296858, 1135.477680267078, 1154.0825044089968, 1198.3528894397016, 1215.835862158606, 1233.5867484392738, 12603.243805371707, 12981.935090324583, 13008.154469959421, 13017.08880378374, 15106.413826548163, 4540.88647783808, 4689.155951928686, 4691.014886873726, 4704.529547045337, 4704.741239231875, 11574.363410012362, 11578.305301681758, 11582.536698532133, 11601.593944211912, 11604.30374177552, 4881.292212629149, 5076.390833100052, 5647.435256474319, 5826.446487583673, 5852.678102704307, 4516.796744146522, 5241.344831896013, 5350.117230656898, 5356.009138309425, 5362.758675859595, 3349.1961929136833, 3812.2947254757405, 3838.27072856162, 3911.882643520699, 3942.329803933338, 998.9100980911753, 1022.6574097677361, 1034.7206254311293, 1035.2701345551368, 1037.258360272409, 755.467395486181, 936.4708939449189, 937.8452555328295, 948.6964171465203, 980.3725615606018, 6020.759169633166, 6103.572749907553, 6586.769463068769, 6607.339266073451, 6754.223264324567, 962.6967505235829, 995.4972738766876, 1004.829179039565, 1033.1734612310122, 1044.0446991003298, 3336.382769187708, 3606.5852426971232, 4151.14901445203, 4309.0, 4325.502567204749, 13032.41354139066, 13516.662083447796, 13527.45890164402, 13551.186928784304, 13555.254461004542, 13199.274039927896, 13363.866361336262, 13412.329383530785, 13413.463461461432, 13443.462261509625, 7426.74006409773, 9208.12522810332, 9456.196223321094, 9462.57418416159, 9811.558479868423, 6568.80293591193, 6570.868582628416, 6755.459563234831, 6780.220274668279, 6787.592744435349, 11740.823887641522, 12022.63932082039, 12070.0, 12204.75590488203, 12226.388680566113, 11290.717732056764, 12217.328046957502, 12523.74952500963, 12551.87448125507, 12703.42834572465, 8915.286777057949, 9132.0, 9282.72151835446, 9283.071692830663, 9289.76775580589, 10029.949850250701, 10046.497675116361, 10243.846342304721, 10288.074073333435, 10292.433916134385, 7778.0, 9145.0, 9178.0, 9267.67563135287, 9300.255979521757, 8923.286137108886, 8957.686480973396, 9040.186383225278, 9124.490765039667, 9127.497987610745, 7568.772936811904, 7807.375409967075, 7813.9218607815465, 7928.7621371358955, 7930.722424715107, 5723.141528770718, 5865.384134665969, 5870.735816888165, 5873.3832947539895, 5950.910736338872, 5974.9370428109305, 5989.580729348903, 5999.1601175836295, 6018.307894592178, 6029.065494848305], "value": 5034.015834889639, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [357.6173494361033, 382.73208753872296, 383.5186840515153, 386.63463027439064, 392.51328352842467, 5160.793568257265, 5825.854353641161, 5916.467517923386, 5942.2869255689375, 5973.566344077422, 5596.103409516673, 5685.8578535536635, 5754.884902301951, 5795.71021448928, 5796.8260952171395, 4510.797014134372, 4532.66005049621, 4536.432945881765, 4576.771161441931, 4585.0, 3838.7715930902123, 4003.359462486003, 4377.927407785097, 4560.061973661197, 4591.783177457976, 3817.9045523861846, 4400.669949753766, 4484.798184081707, 4547.18150732868, 4772.021735544223, 4490.910181796378, 4491.528389519119, 4492.0, 4500.189965806154, 4536.206163921301, 3361.4957756336744, 3983.3626619740703, 3986.521617405901, 3996.300647386696, 4023.939640905389, 5037.798488060474, 5407.432219616923, 5728.3126024876865, 5737.110747834093, 5749.683767392792, 5308.973455132699, 5324.1747529133045, 5324.227986941872, 5328.6802791832615, 5336.226247194174, 6167.383261673796, 6230.2523697156175, 6260.812175634738, 6278.4035516625845, 6278.843028924313, 3763.5483741951143, 3975.6421922026866, 4082.0, 4325.956740432587, 4430.091831174602, 5509.586780991402, 6324.494040476797, 6541.28045914949, 6580.901286480706, 6596.30738772422, 4672.532746725368, 5411.512963833274, 5623.6906970116215, 5626.493615574536, 5645.887082258332, 5521.806736764194, 5553.007796143732, 5764.596478246566, 5768.7980920668415, 5847.8245652630485, 4962.702237865739, 5904.166000319785, 5971.4327138921735, 6016.308124565643, 6025.78909738157, 6366.713497892606, 6426.4216220540375, 6444.486650206423, 6469.344820176585, 6471.255805582324, 1949.9762624622188, 1978.8120128587761, 1985.463924740312, 1993.2126809910005, 2007.7992200779804, 1286.5625687266374, 1554.3782487005062, 1557.1202270717008, 1575.5115914066675, 1589.6105454163803, 5041.6722913010535, 5559.748301937721, 6018.608790428608, 6040.214772079689, 6045.0, 6318.629354199611, 6605.801825945229, 6620.966895165493, 6625.734970601122, 6639.86720265592, 5806.738696758572, 5948.762049518057, 6004.3395226525045, 6010.579259451883, 6045.0, 3103.844807759648, 3423.2297733010373, 3459.515667806509, 3465.9480107798404, 3469.1847415857255, 6222.844428889223, 6286.088517164985, 6471.385218404244, 6636.170478690164, 6827.351401616937, 6001.609895356875, 6323.336049714806, 6342.304520578736, 6722.932770672329, 6742.348124709478, 6529.498215410482, 6701.800834228222, 6793.286704895915, 6798.164495586164, 6821.908494640834, 5097.745112744274, 6501.44737697301, 6517.608943463408, 6547.0, 6609.867802644017, 5013.323201367769, 6082.574219804571, 6313.210848643919, 6354.745810167727, 6474.70863811139, 6024.186734790747, 6051.819895120585, 6746.089277947611, 6786.932130678828, 6839.2818754032105, 5394.244805727123, 5501.944980550144, 5582.581306402118, 5609.298837645294, 5627.831165065055, 5469.781208751605, 6519.4132528072705, 6530.510211734044, 6548.0832683425315, 6555.787179371831, 5316.441773613715, 6017.849553761191, 6336.303006669171, 6347.619142851444, 6357.205349331333, 5529.30883639545, 5714.5999780015, 5763.769449221984, 6236.812895613139, 6336.809895703136, 5932.911006334822, 6216.160818289473, 6233.844153896008, 6251.156093927261, 6277.748890044347, 4770.952290477051, 5863.736131874161, 6273.215848018997, 6358.895460358108, 6387.297397286202, 4987.426445958761, 5173.767180476812, 6073.930466587309, 6147.262328520606, 6207.565470417208], "value": 4831.969131224377, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [684.6029303004257, 741.336503829073, 790.3400660448525, 829.85062688716, 830.8299376381824, 14938.178400187999, 15537.300821463034, 15551.144687042208, 15567.377304907805, 15592.064476131425, 14510.056846304982, 14572.344244508997, 14733.92633036836, 14757.631059223524, 14825.0, 924.8843894513169, 943.1935694980796, 947.6304241345881, 948.1135138645354, 949.4588084791671, 940.6848705683605, 945.4469135555709, 963.9469829159393, 970.6020531582053, 970.8252514547379, 1022.166933948833, 1022.3508072374021, 1024.6618615856748, 1024.6874703215517, 1025.1593693171603, 1017.2929813779426, 1018.0989824005808, 1018.383877753963, 1020.2654089055868, 1020.3724709303799, 754.6340025087828, 757.2200633347661, 758.0789340950771, 759.9886001709979, 760.0575286644521, 15606.921965390215, 15925.28336224861, 15970.0, 16203.432879849266, 16471.846970712057, 14610.123392596372, 14742.557723268212, 14855.628609284746, 14893.180875051868, 15587.532374028797, 11300.491477883434, 11523.11687278017, 11626.244294120856, 11681.415929203506, 12271.447784849703, 3712.9071773205615, 3742.0943416832883, 3796.6013568575454, 3870.4774855394444, 3881.0, 106958.86082278311, 109781.9999999992, 115216.0, 115618.26572601417, 120083.39958300239, 11499.827502587468, 11616.477258523386, 11789.88210117905, 11922.463489142836, 12065.396730163457, 25120.497590048097, 25189.496210075697, 25201.62197567038, 25220.117295894557, 25243.62134567983, 7080.681369338392, 7239.877818938073, 7509.061367329084, 7602.733904313433, 7716.2283771623515, 4146.274401979642, 4159.833606655699, 4269.18885411777, 4525.773711314421, 4563.863084107482, 3391.1522119470133, 3443.9311213775586, 3480.0777793884135, 3482.390581648252, 3482.7562070655317, 531.7261610270714, 633.6356594957917, 635.1520719838975, 642.2229102785589, 642.6304874697067, 492.8546078906731, 602.254236615476, 609.436271448908, 646.4149944300416, 647.799182253503, 8755.76495901024, 9117.908820911705, 10018.39889606626, 10032.44821534808, 10286.27996040285, 553.8120731031914, 568.590614757374, 584.3134317177299, 629.7292164369366, 701.6912558474255, 4255.595718406808, 4802.591779698765, 4806.2310030394965, 4826.396700412449, 4859.465458799529, 97131.0, 97440.51279743556, 98925.0, 100144.49783253256, 101891.47162792564, 47762.0, 70658.64670676614, 72222.27777722261, 83345.58327208325, 85440.71838922422, 67202.3279767196, 68621.65689171522, 69593.65203173952, 69665.30334696689, 70355.64822175856, 10487.685369438928, 10564.735881603021, 10826.51280692355, 10957.452127393757, 10991.175661825235, 34598.481022785185, 47914.0, 50181.0, 50502.0, 52005.7399712999, 70197.29802702111, 70502.0, 72415.27584724085, 72873.6356318215, 73268.26731732614, 11638.53445862156, 13390.933045335101, 13469.057165998678, 13843.169409835442, 14225.217613031382, 14294.428222870969, 14470.204138772047, 14740.115593064022, 14856.777148343, 15015.399384024953, 13546.729065418833, 13876.444942202603, 13879.653008674864, 13913.234772087633, 14175.574732758034, 13440.462381505022, 13464.798028029783, 13625.0, 14069.718605628035, 14173.078749881224, 13165.736685266433, 13937.930310348384, 13993.860061399255, 14146.504872329831, 14149.504767333094, 11053.557857685602, 11112.9838197968, 11187.216894817284, 11359.148063895076, 12473.750524989631, 9769.85345219808, 9873.605055797974, 11281.21031527785, 11291.774164516828, 11307.208495405572], "value": 7628.309405031816, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1452.8999999999996, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [114.0, 115.0, 115.0, 115.0, 116.0, 112.0, 107.0, 115.0, 115.0, 114.0], "value": 113.8, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [153.0, 112.0, 113.0, 150.0, 114.0, 112.0, 110.0, 96.0, 134.0, 112.0], "value": 120.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 185.0, 187.0, 188.0, 186.0, 186.0, 181.0, 189.0, 186.0, 186.0], "value": 185.9, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [79.0, 60.0, 59.0, 113.0, 85.0, 68.0, 60.0, 60.0, 77.0, 59.0], "value": 72.0, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [91.0, 70.0, 85.0, 69.0, 70.0, 68.0, 84.0, 70.0, 68.0, 85.0], "value": 76.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 86.0, 87.0, 86.0, 88.0, 87.0, 87.0, 85.0, 86.0, 86.0], "value": 86.4, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 93.0, 95.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 88.0, 87.0, 86.0, 85.0, 84.0, 86.0, 85.0, 86.0, 84.0], "value": 85.8, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [65.0, 63.0, 63.0, 61.0, 63.0, 62.0, 63.0, 63.0, 61.0, 62.0], "value": 62.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 59.0, 67.0, 68.0, 64.0, 59.0, 74.0, 82.0, 84.0, 84.0], "value": 69.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 84.0, 84.0, 82.0, 83.0, 81.0, 83.0, 82.0], "value": 82.6, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [139.0, 139.0, 141.0, 141.0, 143.0, 142.0, 151.0, 140.0, 177.0, 148.0], "value": 146.1, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [181.0, 177.0, 184.0, 189.0, 187.0, 180.0, 192.0, 234.0, 191.0, 183.0], "value": 189.8, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 67.0, 67.0, 67.0, 68.0, 69.0, 67.0, 68.0, 68.0, 68.0], "value": 67.7, "unit": "score"}]}]} 05:35:10 INFO - Return code: 0 05:35:10 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:35:10 ERROR - # TBPL SUCCESS # 05:35:10 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:35:10 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:35:10 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:35:10 INFO - 2017-03-20 05:35:10.378 screenresolution[6795:130956] starting screenresolution argv=screenresolution get 05:35:10 INFO - 2017-03-20 05:35:10.381 screenresolution[6795:130956] Display 0: 1600x1200x32@60 05:35:10 INFO - 2017-03-20 05:35:10.387 screenresolution[6796:130959] starting screenresolution argv=screenresolution list 05:35:10 INFO - Available Modes on Display 0 05:35:10 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:35:10 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:35:10 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:35:10 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:35:10 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:35:10 INFO - Intel Iris: 05:35:10 INFO - Chipset Model: Intel Iris 05:35:10 INFO - Type: GPU 05:35:10 INFO - Bus: Built-In 05:35:10 INFO - VRAM (Dynamic, Max): 1536 MB 05:35:10 INFO - Vendor: Intel (0x8086) 05:35:10 INFO - Device ID: 0x0a2e 05:35:10 INFO - Revision ID: 0x0009 05:35:10 INFO - Displays: 05:35:10 INFO - Display: 05:35:10 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:35:10 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:35:10 INFO - Display Serial Number: 1600x1200 60 05:35:10 INFO - Main Display: Yes 05:35:10 INFO - Mirror: Off 05:35:10 INFO - Online: Yes 05:35:10 INFO - Rotation: Supported 05:35:10 INFO - Return code: 0 05:35:10 INFO - Running post-action listener: _resource_record_post_action 05:35:10 INFO - [mozharness: 2017-03-20 12:35:10.629534Z] Finished run-tests step (success) 05:35:10 INFO - Running post-run listener: _resource_record_post_run 05:35:10 INFO - Total resource usage - Wall time: 1202s; CPU: 54.0%; Read bytes: 336384; Write bytes: 511532032; Read time: 5; Write time: 1745 05:35:10 INFO - TinderboxPrint: CPU usage
53.6% 05:35:10 INFO - TinderboxPrint: I/O read bytes / time
336,384 / 5 05:35:10 INFO - TinderboxPrint: I/O write bytes / time
511,532,032 / 1,745 05:35:10 INFO - TinderboxPrint: CPU idle
2,232.5 (46.4%) 05:35:10 INFO - TinderboxPrint: CPU system
962.6 (20.0%) 05:35:10 INFO - TinderboxPrint: CPU user
1,614.6 (33.6%) 05:35:10 INFO - TinderboxPrint: Swap in / out
210,317,312 / 0 05:35:10 INFO - install - Wall time: 21s; CPU: 54.0%; Read bytes: 205672960; Write bytes: 201388032; Read time: 15695; Write time: 367 05:35:10 INFO - run-tests - Wall time: 1183s; CPU: 54.0%; Read bytes: 335872; Write bytes: 299330560; Read time: 5; Write time: 1343 05:35:11 INFO - Running post-run listener: _upload_blobber_files 05:35:11 INFO - Blob upload gear active. 05:35:11 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:35:11 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:35:11 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', 'Pine', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:35:11 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 Pine -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:35:11 INFO - (blobuploader) - INFO - Open directory for files ... 05:35:11 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:35:11 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:11 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:12 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:35:12 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:12 INFO - (blobuploader) - INFO - Done attempting. 05:35:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:35:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:35:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:13 INFO - (blobuploader) - INFO - Done attempting. 05:35:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:35:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:14 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:35:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:14 INFO - (blobuploader) - INFO - Done attempting. 05:35:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:35:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:35:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:35:16 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:35:16 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:35:16 INFO - (blobuploader) - INFO - Done attempting. 05:35:16 INFO - (blobuploader) - INFO - Iteration through files over. 05:35:16 INFO - Return code: 0 05:35:16 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:35:16 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:35:16 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/b15bb8d4bd15d60020e52a48252a3a734618fd04f3d92b61a80453a88c931a44744e9efa5f1dfda30e2a66ebd3765d1deb13e389312ba74641dba0cf1f7349d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/1898f05f9b5745b63f7298398330ffc27dbac02f14bae9b7e2cfaba92d729ed44c4f09dca86778cf59fb60497c964d6998bf4f27e089b6a3e8443fff61d91efa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/1f9659868960041be3aec516867b26f394a7df2842dad5b39a978d4e9c566706533deb7b48bc084cc45bbaa36c594ee9162ba151617692f368b2e94be21fe45e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e26250fd6e220ee323cecdef326e3429936c56497c507ca60efd1ad26ecb3172d8ff6f5d5221dede0c7ebdb06bf9769bea273404154a700aba5a59bf5e9bd51c"} 05:35:16 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:35:16 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:35:16 INFO - Contents: 05:35:16 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/b15bb8d4bd15d60020e52a48252a3a734618fd04f3d92b61a80453a88c931a44744e9efa5f1dfda30e2a66ebd3765d1deb13e389312ba74641dba0cf1f7349d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/1898f05f9b5745b63f7298398330ffc27dbac02f14bae9b7e2cfaba92d729ed44c4f09dca86778cf59fb60497c964d6998bf4f27e089b6a3e8443fff61d91efa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/1f9659868960041be3aec516867b26f394a7df2842dad5b39a978d4e9c566706533deb7b48bc084cc45bbaa36c594ee9162ba151617692f368b2e94be21fe45e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e26250fd6e220ee323cecdef326e3429936c56497c507ca60efd1ad26ecb3172d8ff6f5d5221dede0c7ebdb06bf9769bea273404154a700aba5a59bf5e9bd51c"} 05:35:16 INFO - Running post-run listener: copy_logs_to_upload_dir 05:35:16 INFO - Copying logs to upload dir... 05:35:16 INFO - mkdir: /builds/slave/test/build/upload/logs 05:35:16 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1285.975643 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-03-20 05:35:16.837583) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 05:35:16.841401) ========= 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.u5IS0nUcfL/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.Pv3N13f6nG/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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/Pine/sha512/b15bb8d4bd15d60020e52a48252a3a734618fd04f3d92b61a80453a88c931a44744e9efa5f1dfda30e2a66ebd3765d1deb13e389312ba74641dba0cf1f7349d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/1898f05f9b5745b63f7298398330ffc27dbac02f14bae9b7e2cfaba92d729ed44c4f09dca86778cf59fb60497c964d6998bf4f27e089b6a3e8443fff61d91efa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/1f9659868960041be3aec516867b26f394a7df2842dad5b39a978d4e9c566706533deb7b48bc084cc45bbaa36c594ee9162ba151617692f368b2e94be21fe45e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e26250fd6e220ee323cecdef326e3429936c56497c507ca60efd1ad26ecb3172d8ff6f5d5221dede0c7ebdb06bf9769bea273404154a700aba5a59bf5e9bd51c"} build_url:https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011201 build_url: 'https://queue.taskcluster.net/v1/task/Dnal0tKyRAmCzmmPVUzWNw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/b15bb8d4bd15d60020e52a48252a3a734618fd04f3d92b61a80453a88c931a44744e9efa5f1dfda30e2a66ebd3765d1deb13e389312ba74641dba0cf1f7349d7", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/1898f05f9b5745b63f7298398330ffc27dbac02f14bae9b7e2cfaba92d729ed44c4f09dca86778cf59fb60497c964d6998bf4f27e089b6a3e8443fff61d91efa", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/1f9659868960041be3aec516867b26f394a7df2842dad5b39a978d4e9c566706533deb7b48bc084cc45bbaa36c594ee9162ba151617692f368b2e94be21fe45e", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Pine/sha512/e26250fd6e220ee323cecdef326e3429936c56497c507ca60efd1ad26ecb3172d8ff6f5d5221dede0c7ebdb06bf9769bea273404154a700aba5a59bf5e9bd51c"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-03-20 05:35:16.875536) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 05:35:16.875852) ========= 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.u5IS0nUcfL/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.Pv3N13f6nG/Listeners TMPDIR=/var/folders/8q/yndjsd4s3gdcrwzkrbfc4fc000000w/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.005544 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-03-20 05:35:16.924831) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 05:35:16.925237) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-03-20 05:35:16.925549) ========= ========= Total master_lag: 0.19 =========