builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0014 starttime: 1493569910.37 results: success (0) buildid: 20170430075046 builduid: 4dbbad5eaf8244a89bf25e7fbf14e6f7 revision: e2f942326f941f481b004ecbb7b9d18e55bd4322 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:50.370549) ========= master: http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:50.371082) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:50.371377) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:50.478401) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:50.478821) ========= 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.Waj73tYHrs/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.x42kCU61Yf/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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-04-30 09:31:50-- 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% 15.6M=0.001s 2017-04-30 09:31:51 (15.6 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.558081 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:51.062008) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:51.062316) ========= 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.Waj73tYHrs/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.x42kCU61Yf/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.031444 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:51.117995) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-30 09:31:51.118361) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev e2f942326f941f481b004ecbb7b9d18e55bd4322 --destination scripts --debug' in dir /builds/slave/test/. (timeout 1200 secs) watching logfiles {} argv: ['bash', '-c', u'python archiver_client.py mozharness --repo mozilla-central --rev e2f942326f941f481b004ecbb7b9d18e55bd4322 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Waj73tYHrs/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.x42kCU61Yf/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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-04-30 09:31:51,208 truncating revision to first 12 chars 2017-04-30 09:31:51,208 Setting DEBUG logging. 2017-04-30 09:31:51,208 attempt 1/10 2017-04-30 09:31:51,208 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/e2f942326f94?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-30 09:31:51,984 unpacking tar archive at: mozilla-central-e2f942326f94/testing/mozharness/ program finished with exit code 0 elapsedTime=1.051905 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-30 09:31:52.196694) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:52.197181) ========= script_repo_revision: e2f942326f941f481b004ecbb7b9d18e55bd4322 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:52.197601) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:52.197878) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-30 09:31:52.221370) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-30 09:31:52.221705) ========= /tools/buildbot/bin/python -u scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox in dir /builds/slave/test/. (timeout 3600 secs) (maxTime 7200 secs) watching logfiles {} argv: ['/tools/buildbot/bin/python', '-u', 'scripts/scripts/talos_script.py', '--suite', 'dromaeojs', '--add-option', '--webServer,localhost', '--branch-name', 'Firefox', '--cfg', 'talos/mac_config.py', '--download-symbols', 'ondemand', '--use-talos-json', '--blob-upload-branch', 'Firefox'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.Waj73tYHrs/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.x42kCU61Yf/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 09:31:52 INFO - MultiFileLogger online at 20170430 09:31:52 in /builds/slave/test 09:31:52 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 09:31:52 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 09:31:52 INFO - {'append_to_log': False, 09:31:52 INFO - 'base_work_dir': '/builds/slave/test', 09:31:52 INFO - 'blob_upload_branch': 'Firefox', 09:31:52 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 09:31:52 INFO - 'branch': 'Firefox', 09:31:52 INFO - 'buildbot_json_path': 'buildprops.json', 09:31:52 INFO - 'config_files': ('talos/mac_config.py',), 09:31:52 INFO - 'default_actions': ('clobber', 09:31:52 INFO - 'read-buildbot-config', 09:31:52 INFO - 'download-and-extract', 09:31:52 INFO - 'populate-webroot', 09:31:52 INFO - 'create-virtualenv', 09:31:52 INFO - 'install', 09:31:52 INFO - 'run-tests'), 09:31:52 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 09:31:52 INFO - 'download_minidump_stackwalk': True, 09:31:52 INFO - 'download_symbols': 'ondemand', 09:31:52 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 09:31:52 INFO - 'tooltool.py': '/tools/tooltool.py', 09:31:52 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 09:31:52 INFO - '/tools/misc-python/virtualenv.py')}, 09:31:52 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 09:31:52 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 09:31:52 INFO - 'gecko_profile': False, 09:31:52 INFO - 'gecko_profile_interval': 0, 09:31:52 INFO - 'installer_path': 'installer.exe', 09:31:52 INFO - 'log_level': 'info', 09:31:52 INFO - 'log_name': 'talos', 09:31:52 INFO - 'log_to_console': True, 09:31:52 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 09:31:52 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 09:31:52 INFO - 'opt_config_files': (), 09:31:52 INFO - 'pip_index': False, 09:31:52 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:31:52 INFO - 'cmd': ('bash', 09:31:52 INFO - '-c', 09:31:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:31:52 INFO - 'enabled': True, 09:31:52 INFO - 'halt_on_failure': False, 09:31:52 INFO - 'name': 'check_screen_resolution'},), 09:31:52 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 09:31:52 INFO - 'cmd': ('bash', 09:31:52 INFO - '-c', 09:31:52 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 09:31:52 INFO - 'enabled': True, 09:31:52 INFO - 'halt_on_failure': False, 09:31:52 INFO - 'name': 'check_screen_resolution'},), 09:31:52 INFO - 'run_cmd_checks_enabled': True, 09:31:52 INFO - 'suite': 'dromaeojs', 09:31:52 INFO - 'system_bits': '32', 09:31:52 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 09:31:52 INFO - 'title': 't-yosemite-r7-0014', 09:31:52 INFO - 'tooltool_cache': '/builds/tooltool_cache', 09:31:52 INFO - 'use_talos_json': True, 09:31:52 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 09:31:52 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 09:31:52 INFO - 'work_dir': 'build'} 09:31:52 INFO - [mozharness: 2017-04-30 16:31:52.423821Z] Running clobber step. 09:31:52 INFO - Running pre-action listener: _resource_record_pre_action 09:31:52 INFO - Running main action method: clobber 09:31:52 INFO - rmtree: /builds/slave/test/build 09:31:52 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 09:31:57 INFO - Running post-action listener: _resource_record_post_action 09:31:57 INFO - [mozharness: 2017-04-30 16:31:57.239700Z] Finished clobber step (success) 09:31:57 INFO - [mozharness: 2017-04-30 16:31:57.239838Z] Running read-buildbot-config step. 09:31:57 INFO - Running pre-action listener: _resource_record_pre_action 09:31:57 INFO - Running main action method: read_buildbot_config 09:31:57 INFO - Using buildbot properties: 09:31:57 INFO - { 09:31:57 INFO - "project": "", 09:31:57 INFO - "product": "firefox", 09:31:57 INFO - "script_repo_revision": "production", 09:31:57 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 09:31:57 INFO - "repository": "", 09:31:57 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 09:31:57 INFO - "buildid": "20170430075046", 09:31:57 INFO - "pgo_build": "False", 09:31:57 INFO - "basedir": "/builds/slave/test", 09:31:57 INFO - "buildnumber": 59, 09:31:57 INFO - "slavename": "t-yosemite-r7-0014", 09:31:57 INFO - "master": "http://buildbot-master107.bb.releng.scl3.mozilla.com:8201/", 09:31:57 INFO - "platform": "yosemite_r7", 09:31:57 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 09:31:57 INFO - "branch": "mozilla-central", 09:31:57 INFO - "repo_path": "mozilla-central", 09:31:57 INFO - "revision": "e2f942326f941f481b004ecbb7b9d18e55bd4322", 09:31:57 INFO - "stage_platform": "macosx64", 09:31:57 INFO - "builduid": "4dbbad5eaf8244a89bf25e7fbf14e6f7", 09:31:57 INFO - "slavebuilddir": "test" 09:31:57 INFO - } 09:31:57 INFO - Found installer url https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 09:31:57 INFO - Running post-action listener: _resource_record_post_action 09:31:57 INFO - [mozharness: 2017-04-30 16:31:57.243425Z] Finished read-buildbot-config step (success) 09:31:57 INFO - [mozharness: 2017-04-30 16:31:57.243562Z] Running download-and-extract step. 09:31:57 INFO - Running pre-action listener: _resource_record_pre_action 09:31:57 INFO - Running main action method: download_and_extract 09:31:57 INFO - mkdir: /builds/slave/test/build/tests 09:31:57 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:31:57 INFO - trying https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 09:31:57 INFO - Downloading https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/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 09:31:57 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/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 09:31:58 INFO - Downloaded 1325 bytes. 09:31:58 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 09:31:58 INFO - Using the following test package requirements: 09:31:58 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:58 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 09:31:58 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:31:58 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:58 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 09:31:58 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:58 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 09:31:58 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:58 INFO - u'jsshell-mac.zip'], 09:31:58 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:58 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 09:31:58 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 09:31:58 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:58 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 09:31:58 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:58 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 09:31:58 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:58 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 09:31:58 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 09:31:58 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 09:31:58 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 09:31:58 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:31:58 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:31:58 INFO - Fetch https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:31:59 INFO - Content-Length response header: 52700817 09:31:59 INFO - Bytes received: 52700817 09:32:16 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 09:32:16 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 09:32:16 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 09:32:16 INFO - Fetch https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 09:32:18 INFO - Content-Length response header: 52700817 09:32:18 INFO - Bytes received: 52700817 09:32:33 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 09:32:33 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 09:32:33 INFO - Fetch https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 09:32:34 INFO - Content-Length response header: 14408811 09:32:34 INFO - Bytes received: 14408811 09:32:34 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')]} 09:32:34 INFO - trying https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:32:34 INFO - Downloading https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 09:32:34 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/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 09:32:36 INFO - Downloaded 71197596 bytes. 09:32:36 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:32:36 INFO - mkdir: /builds/slave/test/properties 09:32:36 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 09:32:36 INFO - Writing to file /builds/slave/test/properties/build_url 09:32:36 INFO - Contents: 09:32:36 INFO - build_url:https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 09:32:37 INFO - Running post-action listener: _resource_record_post_action 09:32:37 INFO - Running post-action listener: set_extra_try_arguments 09:32:37 INFO - [mozharness: 2017-04-30 16:32:37.588523Z] Finished download-and-extract step (success) 09:32:37 INFO - [mozharness: 2017-04-30 16:32:37.588645Z] Running populate-webroot step. 09:32:37 INFO - Running pre-action listener: _resource_record_pre_action 09:32:37 INFO - Running main action method: populate_webroot 09:32:37 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 09:32:37 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 09:32:37 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 09:32:37 INFO - '--tppagecycles', 09:32:37 INFO - '7'], 09:32:37 INFO - 'tests': ['tsvgm']}}, 09:32:37 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['tresize', 'tcanvasmark']}, 09:32:37 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 09:32:37 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['dromaeo_css', 'kraken']}, 09:32:37 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 09:32:37 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 09:32:37 INFO - 'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:37 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 09:32:37 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 09:32:37 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 09:32:37 INFO - 'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['damp', 'tps']}, 09:32:37 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 09:32:37 INFO - 'tests': ['damp', 'tps']}, 09:32:37 INFO - 'g3': {'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['dromaeo_dom']}, 09:32:37 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 09:32:37 INFO - 'g4': {'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 09:32:37 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 09:32:37 INFO - 'other': {'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['a11yr', 09:32:37 INFO - 'ts_paint', 09:32:37 INFO - 'tpaint', 09:32:37 INFO - 'sessionrestore', 09:32:37 INFO - 'sessionrestore_no_auto_restore', 09:32:37 INFO - 'tabpaint']}, 09:32:37 INFO - 'other-e10s': {'tests': ['a11yr', 09:32:37 INFO - 'ts_paint', 09:32:37 INFO - 'tpaint', 09:32:37 INFO - 'sessionrestore', 09:32:37 INFO - 'sessionrestore_no_auto_restore', 09:32:37 INFO - 'tabpaint']}, 09:32:37 INFO - 'other-e10s_l64': {'tests': ['a11yr', 09:32:37 INFO - 'ts_paint', 09:32:37 INFO - 'tpaint', 09:32:37 INFO - 'sessionrestore', 09:32:37 INFO - 'sessionrestore_no_auto_restore', 09:32:37 INFO - 'tabpaint']}, 09:32:37 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 09:32:37 INFO - 'ts_paint', 09:32:37 INFO - 'tpaint', 09:32:37 INFO - 'sessionrestore', 09:32:37 INFO - 'sessionrestore_no_auto_restore', 09:32:37 INFO - 'tabpaint']}, 09:32:37 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['a11yr', 09:32:37 INFO - 'ts_paint', 09:32:37 INFO - 'tpaint', 09:32:37 INFO - 'sessionrestore', 09:32:37 INFO - 'sessionrestore_no_auto_restore', 09:32:37 INFO - 'tabpaint']}, 09:32:37 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['a11yr', 09:32:37 INFO - 'ts_paint', 09:32:37 INFO - 'tpaint', 09:32:37 INFO - 'sessionrestore', 09:32:37 INFO - 'sessionrestore_no_auto_restore', 09:32:37 INFO - 'tabpaint']}, 09:32:37 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 09:32:37 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 09:32:37 INFO - 'bloom_basic_ref']}, 09:32:37 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['tsvgx', 09:32:37 INFO - 'tsvgr_opacity', 09:32:37 INFO - 'tart', 09:32:37 INFO - 'tscrollx', 09:32:37 INFO - 'cart', 09:32:37 INFO - 'tsvg_static']}, 09:32:37 INFO - 'svgr-e10s': {'tests': ['tsvgx', 09:32:37 INFO - 'tsvgr_opacity', 09:32:37 INFO - 'tart', 09:32:37 INFO - 'tscrollx', 09:32:37 INFO - 'cart', 09:32:37 INFO - 'tsvg_static']}, 09:32:37 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 09:32:37 INFO - 'talos_options': ['--disable-e10s'], 09:32:37 INFO - 'tests': ['tp5o']}, 09:32:37 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 09:32:37 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 09:32:37 INFO - 'talos_options': ['--disable-e10s', 09:32:37 INFO - '--xperf_path', 09:32:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:37 INFO - 'tests': ['tp5n']}, 09:32:37 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 09:32:37 INFO - 'talos_options': ['--xperf_path', 09:32:37 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 09:32:37 INFO - 'tests': ['tp5n']}}, 09:32:37 INFO - 'talos.zip': {'path': '', 09:32:37 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 09:32:37 INFO - Running post-action listener: _resource_record_post_action 09:32:37 INFO - [mozharness: 2017-04-30 16:32:37.607768Z] Finished populate-webroot step (success) 09:32:37 INFO - [mozharness: 2017-04-30 16:32:37.607904Z] Running create-virtualenv step. 09:32:37 INFO - Running pre-action listener: _resource_record_pre_action 09:32:37 INFO - Running main action method: create_virtualenv 09:32:37 INFO - Creating virtualenv /builds/slave/test/build/venv 09:32:37 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 09:32:37 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 09:32:37 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 09:32:37 INFO - Using real prefix '/tools/python27' 09:32:37 INFO - New python executable in /builds/slave/test/build/venv/bin/python 09:32:38 INFO - Installing distribute.............................................................................................................................................................................................done. 09:32:41 INFO - Installing pip.................done. 09:32:41 INFO - Return code: 0 09:32:41 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 09:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 09:32:41 INFO - Reading from file tmpfile_stdout 09:32:41 INFO - Output received: 09:32:41 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) 09:32:41 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 09:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f418b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f41b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc1b56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f6d30>, '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 0x10f11cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1ebbe8>, '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.Waj73tYHrs/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.x42kCU61Yf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 09:32:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 09:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 09:32:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Waj73tYHrs/Render', 09:32:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:41 INFO - 'HOME': '/Users/cltbld', 09:32:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:41 INFO - 'LOGNAME': 'cltbld', 09:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:41 INFO - 'MOZ_NO_REMOTE': '1', 09:32:41 INFO - 'NO_EM_RESTART': '1', 09:32:41 INFO - 'PAGER': '/bin/cat', 09:32:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:41 INFO - 'PWD': '/builds/slave/test', 09:32:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:41 INFO - 'SHELL': '/bin/bash', 09:32:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x42kCU61Yf/Listeners', 09:32:41 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:32:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:41 INFO - 'USER': 'cltbld', 09:32:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:41 INFO - 'XPC_FLAGS': '0x0', 09:32:41 INFO - 'XPC_SERVICE_NAME': '0', 09:32:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:41 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 09:32:41 INFO - Cleaning up... 09:32:41 INFO - Return code: 0 09:32:41 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 09:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:41 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:41 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:41 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:41 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:41 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:41 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x10f418b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f41b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc1b56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f6d30>, '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 0x10f11cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1ebbe8>, '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.Waj73tYHrs/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.x42kCU61Yf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 09:32:41 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 09:32:41 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 09:32:41 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Waj73tYHrs/Render', 09:32:41 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:41 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:41 INFO - 'HOME': '/Users/cltbld', 09:32:41 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:41 INFO - 'LOGNAME': 'cltbld', 09:32:41 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:41 INFO - 'MOZ_NO_REMOTE': '1', 09:32:41 INFO - 'NO_EM_RESTART': '1', 09:32:41 INFO - 'PAGER': '/bin/cat', 09:32:41 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:41 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:41 INFO - 'PWD': '/builds/slave/test', 09:32:41 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:41 INFO - 'SHELL': '/bin/bash', 09:32:41 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x42kCU61Yf/Listeners', 09:32:41 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:32:41 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:41 INFO - 'USER': 'cltbld', 09:32:41 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:41 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:41 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:41 INFO - 'XPC_FLAGS': '0x0', 09:32:41 INFO - 'XPC_SERVICE_NAME': '0', 09:32:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:42 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:42 INFO - Downloading/unpacking psutil>=3.1.1 09:32:42 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 09:32:42 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 09:32:42 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 09:32:42 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 09:32:42 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 09:32:42 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 09:32:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 09:32:46 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:46 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:46 INFO - Installing collected packages: psutil 09:32:46 INFO - Running setup.py install for psutil 09:32:46 INFO - building 'psutil._psutil_osx' extension 09:32:46 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 09:32:46 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 09:32:47 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 09:32:47 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 09:32:47 INFO - building 'psutil._psutil_posix' extension 09:32:47 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 09:32:47 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 09:32:47 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 09:32:47 INFO - ^ 09:32:47 INFO - 1 warning generated. 09:32:47 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 09:32:47 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 09:32:47 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 09:32:47 INFO - Successfully installed psutil 09:32:47 INFO - Cleaning up... 09:32:47 INFO - Return code: 0 09:32:47 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 09:32: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')]} 09:32:47 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:47 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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')]} 09:32:47 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:47 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f418b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f41b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc1b56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f6d30>, '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 0x10f11cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1ebbe8>, '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.Waj73tYHrs/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.x42kCU61Yf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 09:32: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 09:32: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 mozsystemmonitor==0.3 09:32:47 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Waj73tYHrs/Render', 09:32:47 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:47 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:47 INFO - 'HOME': '/Users/cltbld', 09:32:47 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:47 INFO - 'LOGNAME': 'cltbld', 09:32:47 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:47 INFO - 'MOZ_NO_REMOTE': '1', 09:32:47 INFO - 'NO_EM_RESTART': '1', 09:32:47 INFO - 'PAGER': '/bin/cat', 09:32:47 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:47 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:47 INFO - 'PWD': '/builds/slave/test', 09:32:47 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:47 INFO - 'SHELL': '/bin/bash', 09:32:47 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x42kCU61Yf/Listeners', 09:32:47 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:32:47 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:47 INFO - 'USER': 'cltbld', 09:32:47 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:47 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:47 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:47 INFO - 'XPC_FLAGS': '0x0', 09:32:47 INFO - 'XPC_SERVICE_NAME': '0', 09:32:47 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:47 INFO - Downloading/unpacking mozsystemmonitor==0.3 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32:50 INFO - Downloading mozsystemmonitor-0.3.tar.gz 09:32:50 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 09:32:50 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 09:32:50 INFO - Installing collected packages: mozsystemmonitor 09:32:50 INFO - Running setup.py install for mozsystemmonitor 09:32:50 INFO - Successfully installed mozsystemmonitor 09:32:50 INFO - Cleaning up... 09:32:50 INFO - Return code: 0 09:32:50 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 09:32:50 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')]} 09:32:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:50 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')]} 09:32:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:50 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 0x10f418b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f41b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc1b56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f6d30>, '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 0x10f11cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1ebbe8>, '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.Waj73tYHrs/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.x42kCU61Yf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 09:32:50 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 09:32:50 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 09:32:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Waj73tYHrs/Render', 09:32:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:50 INFO - 'HOME': '/Users/cltbld', 09:32:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:50 INFO - 'LOGNAME': 'cltbld', 09:32:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:50 INFO - 'MOZ_NO_REMOTE': '1', 09:32:50 INFO - 'NO_EM_RESTART': '1', 09:32:50 INFO - 'PAGER': '/bin/cat', 09:32:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:50 INFO - 'PWD': '/builds/slave/test', 09:32:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:50 INFO - 'SHELL': '/bin/bash', 09:32:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x42kCU61Yf/Listeners', 09:32:50 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:32:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:50 INFO - 'USER': 'cltbld', 09:32:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:50 INFO - 'XPC_FLAGS': '0x0', 09:32:50 INFO - 'XPC_SERVICE_NAME': '0', 09:32:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:51 INFO - Downloading/unpacking jsonschema==2.5.1 09:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:53 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 09:32:53 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 09:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:53 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:53 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:53 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:53 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:54 INFO - Downloading functools32-3.2.3-2.tar.gz 09:32:54 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 09:32:54 INFO - warning: no files found matching '*.txt' 09:32:54 INFO - no previously-included directories found matching 'build' 09:32:54 INFO - no previously-included directories found matching 'dist' 09:32:54 INFO - no previously-included directories found matching '.git*' 09:32:54 INFO - Installing collected packages: jsonschema, functools32 09:32:54 INFO - Running setup.py install for functools32 09:32:54 INFO - warning: no files found matching '*.txt' 09:32:54 INFO - no previously-included directories found matching 'build' 09:32:54 INFO - no previously-included directories found matching 'dist' 09:32:54 INFO - no previously-included directories found matching '.git*' 09:32:54 INFO - Successfully installed jsonschema functools32 09:32:54 INFO - Cleaning up... 09:32:54 INFO - Return code: 0 09:32:54 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 09:32:54 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')]} 09:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:54 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')]} 09:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:54 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 0x10f418b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f41b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc1b56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f6d30>, '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 0x10f11cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1ebbe8>, '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.Waj73tYHrs/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.x42kCU61Yf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 09:32:54 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 09:32:54 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 09:32:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Waj73tYHrs/Render', 09:32:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:54 INFO - 'HOME': '/Users/cltbld', 09:32:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:54 INFO - 'LOGNAME': 'cltbld', 09:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:54 INFO - 'MOZ_NO_REMOTE': '1', 09:32:54 INFO - 'NO_EM_RESTART': '1', 09:32:54 INFO - 'PAGER': '/bin/cat', 09:32:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:54 INFO - 'PWD': '/builds/slave/test', 09:32:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:54 INFO - 'SHELL': '/bin/bash', 09:32:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x42kCU61Yf/Listeners', 09:32:54 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:32:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:54 INFO - 'USER': 'cltbld', 09:32:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:54 INFO - 'XPC_FLAGS': '0x0', 09:32:54 INFO - 'XPC_SERVICE_NAME': '0', 09:32:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:54 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 09:32:54 INFO - Cleaning up... 09:32:54 INFO - Return code: 0 09:32:54 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 09:32:54 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')]} 09:32:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:54 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')]} 09:32:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:54 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 0x10f418b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f41b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc1b56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f6d30>, '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 0x10f11cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1ebbe8>, '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.Waj73tYHrs/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.x42kCU61Yf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 09:32:54 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 09:32:54 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 09:32:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Waj73tYHrs/Render', 09:32:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:54 INFO - 'HOME': '/Users/cltbld', 09:32:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:54 INFO - 'LOGNAME': 'cltbld', 09:32:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:54 INFO - 'MOZ_NO_REMOTE': '1', 09:32:54 INFO - 'NO_EM_RESTART': '1', 09:32:54 INFO - 'PAGER': '/bin/cat', 09:32:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:54 INFO - 'PWD': '/builds/slave/test', 09:32:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:54 INFO - 'SHELL': '/bin/bash', 09:32:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x42kCU61Yf/Listeners', 09:32:54 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:32:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:54 INFO - 'USER': 'cltbld', 09:32:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:54 INFO - 'XPC_FLAGS': '0x0', 09:32:54 INFO - 'XPC_SERVICE_NAME': '0', 09:32:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:32:54 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:32:54 INFO - Downloading/unpacking blobuploader==1.2.4 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32: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 09:32:57 INFO - Downloading blobuploader-1.2.4.tar.gz 09:32:57 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 09:32:57 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 09:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:57 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:57 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 09:32:57 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 09:32:57 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 09:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 09:32:58 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 09:32:58 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 09:32:58 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 09:32:58 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 09:32:58 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 09:32:58 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 09:32:58 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 09:32:58 INFO - Downloading docopt-0.6.1.tar.gz 09:32:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 09:32:58 INFO - Installing collected packages: blobuploader, requests, docopt 09:32:58 INFO - Running setup.py install for blobuploader 09:32:59 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 09:32:59 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 09:32:59 INFO - Running setup.py install for requests 09:32:59 INFO - Running setup.py install for docopt 09:32:59 INFO - Successfully installed blobuploader requests docopt 09:32:59 INFO - Cleaning up... 09:32:59 INFO - Return code: 0 09:32:59 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:32:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:32:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:32:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:32:59 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 0x10f418b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f41b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc1b56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f6d30>, '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 0x10f11cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1ebbe8>, '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.Waj73tYHrs/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.x42kCU61Yf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 09:32:59 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 09:32:59 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 09:32:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Waj73tYHrs/Render', 09:32:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:32:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:32:59 INFO - 'HOME': '/Users/cltbld', 09:32:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:32:59 INFO - 'LOGNAME': 'cltbld', 09:32:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:32:59 INFO - 'MOZ_NO_REMOTE': '1', 09:32:59 INFO - 'NO_EM_RESTART': '1', 09:32:59 INFO - 'PAGER': '/bin/cat', 09:32:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:32:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:32:59 INFO - 'PWD': '/builds/slave/test', 09:32:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:32:59 INFO - 'SHELL': '/bin/bash', 09:32:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x42kCU61Yf/Listeners', 09:32:59 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:32:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:32:59 INFO - 'USER': 'cltbld', 09:32:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:32:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:32:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:32:59 INFO - 'XPC_FLAGS': '0x0', 09:32:59 INFO - 'XPC_SERVICE_NAME': '0', 09:32:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:00 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:00 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-gT1GGT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:00 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-168SHo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:00 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-mHzoJV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:00 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-Vbz7GG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:00 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-_cSduq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:00 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-BZZ5mA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:00 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-oKTLNT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:00 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-3s9XOZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:00 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:00 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-eCToS9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:01 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-LIr0pG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:01 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-ADeg2M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:01 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-KfZ56F-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:01 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-1nS2AN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:01 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-wqxw27-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:01 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-PtpgNl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:01 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-XSBZTg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:01 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:01 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-b1cFI9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:01 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 09:33:01 INFO - Running setup.py install for manifestparser 09:33:01 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 09:33:01 INFO - Running setup.py install for mozcrash 09:33:02 INFO - Running setup.py install for mozdebug 09:33:02 INFO - Running setup.py install for mozdevice 09:33:02 INFO - Installing dm script to /builds/slave/test/build/venv/bin 09:33:02 INFO - Running setup.py install for mozfile 09:33:02 INFO - Running setup.py install for mozhttpd 09:33:02 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 09:33:02 INFO - Running setup.py install for mozinfo 09:33:02 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 09:33:02 INFO - Running setup.py install for mozInstall 09:33:02 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 09:33:02 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 09:33:02 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 09:33:02 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 09:33:02 INFO - Running setup.py install for mozleak 09:33:03 INFO - Running setup.py install for mozlog 09:33:03 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 09:33:03 INFO - Running setup.py install for moznetwork 09:33:03 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 09:33:03 INFO - Running setup.py install for mozprocess 09:33:03 INFO - Running setup.py install for mozprofile 09:33:03 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 09:33:03 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 09:33:03 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 09:33:03 INFO - Running setup.py install for mozrunner 09:33:03 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 09:33:03 INFO - Running setup.py install for mozscreenshot 09:33:04 INFO - Running setup.py install for moztest 09:33:04 INFO - Running setup.py install for mozversion 09:33:04 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 09:33:04 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 09:33:04 INFO - Cleaning up... 09:33:04 INFO - Return code: 0 09:33:04 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:04 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')]} 09:33:04 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:04 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:04 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')]} 09:33:04 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:04 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:04 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 0x10f418b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f41b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc1b56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f6d30>, '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 0x10f11cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1ebbe8>, '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.Waj73tYHrs/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.x42kCU61Yf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 09:33:04 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 09:33:04 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 09:33:04 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Waj73tYHrs/Render', 09:33:04 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:04 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:04 INFO - 'HOME': '/Users/cltbld', 09:33:04 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:04 INFO - 'LOGNAME': 'cltbld', 09:33:04 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:04 INFO - 'MOZ_NO_REMOTE': '1', 09:33:04 INFO - 'NO_EM_RESTART': '1', 09:33:04 INFO - 'PAGER': '/bin/cat', 09:33:04 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:04 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:04 INFO - 'PWD': '/builds/slave/test', 09:33:04 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:04 INFO - 'SHELL': '/bin/bash', 09:33:04 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x42kCU61Yf/Listeners', 09:33:04 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:33:04 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:04 INFO - 'USER': 'cltbld', 09:33:04 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:04 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:04 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:04 INFO - 'XPC_FLAGS': '0x0', 09:33:04 INFO - 'XPC_SERVICE_NAME': '0', 09:33:04 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:04 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 09:33:04 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-NDrzBo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 09:33:04 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)) 09:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 09:33:04 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-jyBVpt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 09:33:04 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)) 09:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 09:33:04 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-PZVYZA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 09:33:04 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)) 09:33:04 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 09:33:04 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-RHicw0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 09:33:05 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 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)) 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 09:33:05 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-ya1GyI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 09:33:05 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)) 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 09:33:05 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-KvPgd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 09:33:05 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)) 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 09:33:05 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-QUnQqW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 09:33:05 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)) 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 09:33:05 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-NeDDl8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 09:33:05 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)) 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 09:33:05 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-okZLn3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 09:33:05 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)) 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 09:33:05 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-NKZwbZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 09:33:05 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)) 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 09:33:05 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-gHA_U3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 09:33:05 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)) 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 09:33:05 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-jkdVZ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 09:33:05 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)) 09:33:05 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 09:33:05 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-QvfI2t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 09:33:06 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)) 09:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 09:33:06 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-qPybwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 09:33:06 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)) 09:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:06 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-zJR6b6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 09:33:06 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)) 09:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 09:33:06 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-OKF4_T-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 09:33:06 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)) 09:33:06 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 09:33:06 INFO - Running setup.py (path:/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/pip-EblXnc-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 09:33:06 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)) 09:33:06 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)) 09:33:06 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)) 09:33:06 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)) 09:33:06 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:33:06 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.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 09:33:06 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 09:33:06 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 09:33:06 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 09:33:06 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 09:33:06 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 09:33:06 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 09:33:06 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 09:33:09 INFO - Downloading blessings-1.6.tar.gz 09:33:09 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 09:33:09 INFO - Installing collected packages: blessings 09:33:09 INFO - Running setup.py install for blessings 09:33:09 INFO - Successfully installed blessings 09:33:09 INFO - Cleaning up... 09:33:09 INFO - Return code: 0 09:33:09 INFO - Done creating virtualenv /builds/slave/test/build/venv. 09:33:09 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:09 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:09 INFO - Reading from file tmpfile_stdout 09:33:09 INFO - Current package versions: 09:33:09 INFO - blessings == 1.6 09:33:09 INFO - blobuploader == 1.2.4 09:33:09 INFO - docopt == 0.6.1 09:33:09 INFO - functools32 == 3.2.3-2 09:33:09 INFO - jsonschema == 2.5.1 09:33:09 INFO - manifestparser == 1.1 09:33:09 INFO - mozInstall == 1.12 09:33:09 INFO - mozcrash == 1.0 09:33:09 INFO - mozdebug == 0.1 09:33:09 INFO - mozdevice == 0.50 09:33:09 INFO - mozfile == 1.2 09:33:09 INFO - mozhttpd == 0.7 09:33:09 INFO - mozinfo == 0.9 09:33:09 INFO - mozleak == 0.1 09:33:09 INFO - mozlog == 3.4 09:33:09 INFO - moznetwork == 0.27 09:33:09 INFO - mozprocess == 0.25 09:33:09 INFO - mozprofile == 0.28 09:33:09 INFO - mozrunner == 6.13 09:33:09 INFO - mozscreenshot == 0.1 09:33:09 INFO - mozsystemmonitor == 0.3 09:33:09 INFO - moztest == 0.8 09:33:09 INFO - mozversion == 1.4 09:33:09 INFO - psutil == 3.1.1 09:33:09 INFO - requests == 1.2.3 09:33:09 INFO - wsgiref == 0.1.2 09:33:09 INFO - Installing None into virtualenv /builds/slave/test/build/venv 09:33:09 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')]} 09:33:09 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:09 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:09 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')]} 09:33:09 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:09 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:09 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 0x10f418b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f41b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc1b56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f6d30>, '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 0x10f11cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1ebbe8>, '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.Waj73tYHrs/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.x42kCU61Yf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 09:33:09 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 09:33:09 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 09:33:09 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Waj73tYHrs/Render', 09:33:09 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:09 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:09 INFO - 'HOME': '/Users/cltbld', 09:33:09 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:09 INFO - 'LOGNAME': 'cltbld', 09:33:09 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:09 INFO - 'MOZ_NO_REMOTE': '1', 09:33:09 INFO - 'NO_EM_RESTART': '1', 09:33:09 INFO - 'PAGER': '/bin/cat', 09:33:09 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:09 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:09 INFO - 'PWD': '/builds/slave/test', 09:33:09 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:09 INFO - 'SHELL': '/bin/bash', 09:33:09 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x42kCU61Yf/Listeners', 09:33:09 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:33:09 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:09 INFO - 'USER': 'cltbld', 09:33:09 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:09 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:09 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:09 INFO - 'XPC_FLAGS': '0x0', 09:33:09 INFO - 'XPC_SERVICE_NAME': '0', 09:33:09 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:10 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)) 09:33:10 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)) 09:33:10 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)) 09:33:10 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)) 09:33:10 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)) 09:33:10 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)) 09:33:10 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)) 09:33:10 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)) 09:33:10 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)) 09:33:10 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)) 09:33:10 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)) 09:33:10 INFO - Cleaning up... 09:33:10 INFO - Return code: 0 09:33:10 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 09:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:10 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 09:33:10 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:10 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:10 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 09:33:10 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 09:33:10 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10f418b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f41b768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fcc1b56d450>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10f1f6d30>, '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 0x10f11cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1ebbe8>, '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.Waj73tYHrs/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.x42kCU61Yf/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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 09:33:10 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 09:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 09:33:10 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Waj73tYHrs/Render', 09:33:10 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:10 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:10 INFO - 'HOME': '/Users/cltbld', 09:33:10 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:10 INFO - 'LOGNAME': 'cltbld', 09:33:10 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:10 INFO - 'MOZ_NO_REMOTE': '1', 09:33:10 INFO - 'NO_EM_RESTART': '1', 09:33:10 INFO - 'PAGER': '/bin/cat', 09:33:10 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:10 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:10 INFO - 'PWD': '/builds/slave/test', 09:33:10 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:10 INFO - 'SHELL': '/bin/bash', 09:33:10 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x42kCU61Yf/Listeners', 09:33:10 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:33:10 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:10 INFO - 'USER': 'cltbld', 09:33:10 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:10 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:10 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:10 INFO - 'XPC_FLAGS': '0x0', 09:33:10 INFO - 'XPC_SERVICE_NAME': '0', 09:33:10 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:10 INFO - Ignoring indexes: https://pypi.python.org/simple/ 09:33:10 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 09:33:10 INFO - Cleaning up... 09:33:10 INFO - Return code: 0 09:33:10 INFO - Running post-action listener: _resource_record_post_action 09:33:10 INFO - Running post-action listener: _start_resource_monitoring 09:33:10 INFO - Starting resource monitoring. 09:33:10 INFO - [mozharness: 2017-04-30 16:33:10.316546Z] Finished create-virtualenv step (success) 09:33:10 INFO - [mozharness: 2017-04-30 16:33:10.317517Z] Running install step. 09:33:10 INFO - Running pre-action listener: _resource_record_pre_action 09:33:10 INFO - Running main action method: install 09:33:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 09:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 09:33:10 INFO - Reading from file tmpfile_stdout 09:33:10 INFO - Detecting whether we're running mozinstall >=1.0... 09:33:10 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 09:33:10 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 09:33:10 INFO - Reading from file tmpfile_stdout 09:33:10 INFO - Output received: 09:33:10 INFO - Usage: mozinstall [options] installer 09:33:10 INFO - Options: 09:33:10 INFO - -h, --help show this help message and exit 09:33:10 INFO - -d DEST, --destination=DEST 09:33:10 INFO - Directory to install application into. [default: 09:33:10 INFO - "/builds/slave/test"] 09:33:10 INFO - --app=APP Application being installed. [default: firefox] 09:33:10 INFO - mkdir: /builds/slave/test/build/application 09:33:10 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'] 09:33:10 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 09:33:30 INFO - Reading from file tmpfile_stdout 09:33:30 INFO - Output received: 09:33:30 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 09:33:30 INFO - Running post-action listener: _resource_record_post_action 09:33:30 INFO - [mozharness: 2017-04-30 16:33:30.366990Z] Finished install step (success) 09:33:30 INFO - [mozharness: 2017-04-30 16:33:30.367137Z] Running run-tests step. 09:33:30 INFO - Running pre-action listener: _resource_record_pre_action 09:33:30 INFO - Running main action method: run_tests 09:33:30 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:33:30 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:33:30 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:33:30 INFO - 2017-04-30 09:33:30.381 screenresolution[1643:14505] starting screenresolution argv=screenresolution get 09:33:30 INFO - 2017-04-30 09:33:30.384 screenresolution[1643:14505] Display 0: 1600x1200x32@60 09:33:30 INFO - 2017-04-30 09:33:30.389 screenresolution[1644:14507] starting screenresolution argv=screenresolution list 09:33:30 INFO - Available Modes on Display 0 09:33:30 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:33:30 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:33:30 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:33:30 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:33:30 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:33:30 INFO - Intel Iris: 09:33:30 INFO - Chipset Model: Intel Iris 09:33:30 INFO - Type: GPU 09:33:30 INFO - Bus: Built-In 09:33:30 INFO - VRAM (Dynamic, Max): 1536 MB 09:33:30 INFO - Vendor: Intel (0x8086) 09:33:30 INFO - Device ID: 0x0a2e 09:33:30 INFO - Revision ID: 0x0009 09:33:30 INFO - Displays: 09:33:30 INFO - Display: 09:33:30 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:33:30 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:33:30 INFO - Display Serial Number: 1600x1200 60 09:33:30 INFO - Main Display: Yes 09:33:30 INFO - Mirror: Off 09:33:30 INFO - Online: Yes 09:33:30 INFO - Rotation: Supported 09:33:30 INFO - Return code: 0 09:33:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 09:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 09:33:30 INFO - Python 2.7.3 09:33:30 INFO - Return code: 0 09:33:30 INFO - grabbing minidump binary from tooltool 09:33:30 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 09:33:30 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 0x10f1f6d30>, '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 0x10f11cdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10f1ebbe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 09:33:30 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 09:33:30 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 09:33:30 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 09:33:30 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 09:33:30 INFO - Return code: 0 09:33:30 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 09:33:30 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 09:33:30 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 09:33:30 INFO - ENV: RUST_BACKTRACE is now 1 09:33:30 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 09:33:30 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 09:33:30 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--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 09:33:30 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0014 --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 09:33:30 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.Waj73tYHrs/Render', 09:33:30 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 09:33:30 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 09:33:30 INFO - 'HOME': '/Users/cltbld', 09:33:30 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 09:33:30 INFO - 'LOGNAME': 'cltbld', 09:33:30 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 09:33:30 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 09:33:30 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 09:33:30 INFO - 'MOZ_NO_REMOTE': '1', 09:33:30 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 09:33:30 INFO - 'NO_EM_RESTART': '1', 09:33:30 INFO - 'PAGER': '/bin/cat', 09:33:30 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 09:33:30 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 09:33:30 INFO - 'PWD': '/builds/slave/test', 09:33:30 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 09:33:30 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 09:33:30 INFO - 'RUST_BACKTRACE': '1', 09:33:30 INFO - 'SHELL': '/bin/bash', 09:33:30 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.x42kCU61Yf/Listeners', 09:33:30 INFO - 'TMPDIR': '/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/', 09:33:30 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 09:33:30 INFO - 'USER': 'cltbld', 09:33:30 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 09:33:30 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 09:33:30 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 09:33:30 INFO - 'XPC_FLAGS': '0x0', 09:33:30 INFO - 'XPC_SERVICE_NAME': '0', 09:33:30 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 09:33:30 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0014', '--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 09:33:30 INFO - mozversion application_buildid: 20170430075046 09:33:30 INFO - mozversion application_changeset: e2f942326f941f481b004ecbb7b9d18e55bd4322 09:33:30 INFO - mozversion application_display_name: Nightly 09:33:30 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 09:33:30 INFO - mozversion application_name: Firefox 09:33:30 INFO - mozversion application_remotingname: firefox 09:33:30 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 09:33:30 INFO - mozversion application_vendor: Mozilla 09:33:30 INFO - mozversion application_version: 55.0a1 09:33:30 INFO - mozversion platform_buildid: 20170430075046 09:33:30 INFO - mozversion platform_changeset: e2f942326f941f481b004ecbb7b9d18e55bd4322 09:33:30 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 09:33:30 INFO - mozversion platform_version: 55.0a1 09:33:30 INFO - using testdate: 1493570010 09:33:30 INFO - actual date: 1493570010 09:33:30 INFO - starting webserver on 'localhost:49239' 09:33:30 INFO - SUITE-START | Running 2 tests 09:33:30 INFO - TEST-START | dromaeo_css 09:33:30 INFO - operating with platform_type : mac_ 09:33:30 INFO - Initialising browser for dromaeo_css test... 09:33:30 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpjcYZzz/profile http://localhost:49239/getInfo.html) 09:33:33 INFO - PID 1654 | __metrics Screen width/height:1600/1200 09:33:33 INFO - PID 1654 | colorDepth:24 09:33:33 INFO - PID 1654 | Browser inner width/height: 1024/689 09:33:33 INFO - PID 1654 | __metrics 09:33:33 INFO - PID 1654 | 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" 09:33:33 INFO - PID 1654 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:33:34 INFO - TEST-INFO | 1654: exit 0 09:33:34 INFO - Browser initialized. 09:33:34 INFO - Running cycle 1/1 for dromaeo_css test... 09:33:34 INFO - TEST-INFO | started process 1657 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpjcYZzz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:33:47 INFO - PID 1657 | RSS: Main: 241078272 09:33:47 INFO - PID 1657 | 09:36:52 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49239/tests/dromaeo/cssquery-ext.html) 09:36:53 INFO - PID 1657 | RSS: Main: 414511104 09:36:53 INFO - PID 1657 | 09:38:36 INFO - PID 1657 | ************************* 09:38:36 INFO - PID 1657 | A coding exception was thrown and uncaught in a Task. 09:38:36 INFO - PID 1657 | 09:38:36 ERROR - PID 1657 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:38:36 INFO - PID 1657 | Full stack: 09:38:36 INFO - PID 1657 | ************************* 09:38:36 INFO - PID 1657 | ************************* 09:38:36 INFO - PID 1657 | A coding exception was thrown and uncaught in a Task. 09:38:36 INFO - PID 1657 | 09:38:36 ERROR - PID 1657 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:38:36 INFO - PID 1657 | Full stack: 09:38:36 INFO - PID 1657 | ************************* 09:38:36 INFO - PID 1657 | ************************* 09:38:36 INFO - PID 1657 | A coding exception was thrown and uncaught in a Task. 09:38:36 INFO - PID 1657 | 09:38:36 ERROR - PID 1657 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:38:36 INFO - PID 1657 | Full stack: 09:38:36 INFO - PID 1657 | ************************* 09:38:36 INFO - PID 1657 | ************************* 09:38:36 INFO - PID 1657 | A coding exception was thrown and uncaught in a Task. 09:38:36 INFO - PID 1657 | 09:38:36 ERROR - PID 1657 | Full message: TypeError: NetworkError when attempting to fetch resource. 09:38:36 INFO - PID 1657 | Full stack: 09:38:36 INFO - PID 1657 | ************************* 09:39:56 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-ext.html (next: http://localhost:49239/tests/dromaeo/cssquery-jquery.html) 09:39:57 INFO - PID 1657 | RSS: Main: 371126272 09:39:57 INFO - PID 1657 | 09:42:59 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49239/tests/dromaeo/cssquery-mootools.html) 09:42:59 INFO - PID 1657 | RSS: Main: 354426880 09:42:59 INFO - PID 1657 | 09:46:02 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49239/tests/dromaeo/cssquery-prototype.html) 09:46:02 INFO - PID 1657 | RSS: Main: 343293952 09:46:02 INFO - PID 1657 | 09:49:06 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49239/tests/dromaeo/cssquery-yui.html) 09:49:07 INFO - PID 1657 | RSS: Main: 332288000 09:49:07 INFO - PID 1657 | 09:52:09 INFO - PID 1657 | Cycle 1(1): loaded http://localhost:49239/tests/dromaeo/cssquery-yui.html (next: http://localhost:49239/tests/dromaeo/cssquery-dojo.html) 09:52:09 INFO - PID 1657 | RSS: Main: 372969472 09:52:09 INFO - PID 1657 | 09:52:09 INFO - PID 1657 | __start_tp_report 09:52:09 INFO - PID 1657 | _x_x_mozilla_page_load 09:52:09 INFO - PID 1657 | _x_x_mozilla_page_load_details 09:52:09 INFO - PID 1657 | |i|pagename|runs| 09:52:09 INFO - PID 1657 | |0;dojo.html;3491.3715531204375;3491.511188433621;3501.8249087545614;3513.490543871139;3551.8224088795555;4519.66102542309;6054.818355449333;6138.785142520012;6176.444120029197;6202.255729312483;6096.085587161928;6109.053096769997;6148.323684394713;6155.784547540837;6160.845978850531;5099.515546023122;5183.196604526304;5248.632595718283;5274.446183150752;5275.736213189344;5312.150055991042;5364;5386.2997810284605;5387.515123638872;5425.538829199523;5203.03743807393;5266.8419947401635;5273.077211487975;5314.335708036515;5315.963387139509;5301.867453313659;5336.466353364672;5364.678119312854;5377.973110134463;5393.325834270716;5238.528532432061;5267.157254839246;5276.261323414725;5285.207218917155;5285.973570132163;5931.139984702194;6117.938820611781;6136.20229370179;6144.815655530341;6169.321374648785;6404.327545607691;6411.6153030818305;6413.7434502619835;6455.451286640641;6461.289258181596;6531.836704082389;6536.477081833442;6539.9673001635165;6557.967210163966;6575.769848055295;6184.56708030438;6191.84520386994;6249.312575616678;6250.937490625081;6285.277193122758;6404.519661025442;6474.352564743582;6475.643839588868;6669.1996960364095;6674.2658307586125;6314.0844577536;6347.619142851444;6362;6384.776532821329;6391.840203994844;6450.096986421905;6505.251896031922;6505.381988711065;6511.544191906616;6512.576682515716;6420.6468644225015;6428.260750013808;6428.421442070143;6429.196350456193;6431.970884658525;6319.146915166394;6382.904256436157;6387.648679322682;6435.099086127946;6436.452901503425;5175.430702622783;5177.689338639693;5182.5594824439595;5188.299579556787;5203.401608814959;4491.505934347219;4575.993281478136;4667.509911459248;4675.2052151134385;4701.341812146302;4927.605791536668;5891.646501209942;5987.341392446828;6141;6156.353582873734;6399.680015999182;6404.943184374619;6486.870262594722;6520.152380190545;6536.379043990813;6145.801568694062;6152.907706384408;6161.815145545641;6164.537659675542;6176.413240742122;5653.180288858175;5685.60200785941;5697.629654072555;5699.00267453194;5723.656580605177;6437.806865794034;6494.253160886558;6595.703193356215;6694.966525167343;6705.731770729116;6373.362663733775;6402.263739669997;6406.743730250924;6407.231132264158;6409.4231519163495;5537.446255374431;6146.678464130234;6621.569597976116;6648.700808463534;6685.866282674417;6392.968035159981;6400.135981642605;6416.7754128605275;6419.582727122722;6425.742970281323;6492.513061520499;6502.772402965874;6505.837354066186;6531.11829902976;6541.215054193527;6258.186435763321;6332.905006425;6353.809385718436;6358.968205158944;6364.07720880479;6316.273628532594;6355.1420558224045;6358;6359.523035772429;6373.8725225496155;5286.3392075990505;6274.623522588659;6324.335944725737;6326.55714100027;6331.715072821642;6127.128444391353;6171.722272497838;6287.874242515216;6354.205724284465;6363.236411630449;6217.844553886189;6271.937280627318;6301.716422761078;6309.400606942333;6335.049742538656 09:52:09 INFO - PID 1657 | |1;ext.html;748.8352562436262;795.272325821873;801.7714951238896;1136.4204255829525;1142.0977427832013;26317.210483685496;36642.083947901316;37168.25663486736;37210.69762558315;37264.81367593158;38616.61383386165;38817.805910970405;38953;38966.80516597413;38977.41533876987;6004.0693692477735;8345.91654083459;8517.829643407129;8520.488770673748;8531;5995.280566332046;7534.397248220157;8444.619992100339;8463.984321881351;8482.109378515228;8499.830003399928;8542.316614670843;8544.102869198738;8548.82902341956;8611.56942152893;5930.584859059867;8476.66093356265;8506.702265420681;8517.701880434186;8537;5950.077737950582;8130.430869839113;8286.047104582989;8294.294984926288;8302.501849889026;37073.443898341546;37239.81380093109;37363.25273494542;37366.62633373686;37446;3567.0725611341236;3610.1696609779633;3612.0608641753333;3613.963860361389;3614.638536146391;30304.69695303041;30332.393352133055;30347.937822176118;30393.696063039308;30396.54405183924;3111.797733147338;3176.4600017996995;3191.3617276544783;3194.4888817789274;3206.2465320649862;281211.59394203103;289491.55254223594;289570;290261;291038;47421.288680669815;47592;47596.5240347599;47635.52364476311;47636;50831.49168508341;50978;51009;51029;51170.48829511732;13941.233232172124;13997.790033149511;14010.439582416793;14013.159210447406;14015.369308381147;9840.803183936281;11329.43352832355;11333.94333028346;11350.829737553944;11354.772904541864;8776;8877.600507977157;10760.677179684622;10842.837357439645;10872.629484859719;5283.841484755463;5508.669479831223;5527.474889885454;5546.528545073714;5563.749631266603;1034.9534270957824;1038.5638032026416;1040.6201736366172;1072.6942821295893;1075.086176749772;23153;24204.51590968206;24271.393215169763;24310.878445608014;24347.14784982517;1135.914806389524;1137.647329327911;1177.1759768162322;1183.402381797204;1185.0637995983077;12424.75150496985;12447.253164810141;12447.253164810141;12448.62654120378;12454.626361209179;298757;299090;299269;299336;299460;53323.466765332625;53586;53673;53715.73142134264;53744;1519.5365413548973;1542.9739223416302;1584.619691274109;1590.506942847721;1591.8646915012123;21397.93010349445;21680;21818.56362872702;23850.40373990664;23907;37622;37625.4356184652;37646.62353376541;37686.434703478924;37735.24529509449;269759;269879;270103;270159;270459;34008.65991340154;34028.82985585056;34073.65926340705;34084.82957585196;34097.65902340945;35656.108597285274;36464.81767591145;41432.79283603562;42831.57168428276;43547.12905741804;27817.582736259377;28923;29717;29772.255693606967;30241.546376803926;27202.72797272002;29307.85346073341;29888.25279368033;30067.849660751555;30691.846540767154;34765.65234347624;35805.74679886192;35899.82050089733;35936.64063359333;36003.63996360003;28371.290717732223;29016;30085.548716769703;30160.24599385033;30213.093607190942;19905.303314383927;20565.485862853548;23415;23612.645810312515;23693.644595330738 09:52:09 INFO - PID 1657 | |2;jquery.html;376.64030850537733;397.3245482679446;413.8861813001424;437.78986086678395;446.4352593968628;12724.809127863078;14651.194184319858;21032;21193.682094768592;21368.358949231548;21958.23146189884;22041.448963775914;22710.205142820003;22963.311100667008;22986.425339366524;5022.849314520552;5889.322727886305;6017.608855424405;6086.391360863922;6095.420935011167;3571.428571428572;3625.6374362563797;5906.852328691795;6068.059450785136;6068.605540639866;5751.511121554673;6040.275166979968;6079.422454866803;6087.360827113156;6102.145699602059;5780.855478613026;5971.104334349839;6016.037434010537;6061.969690151565;6073.362296958822;5336.466353364672;5339.813106541253;5340.759665815009;5344.305240318772;5350.0904846176245;21967;26185.73814261871;27100.051498197667;27142.72857271422;27510.862445687842;2162.56748650269;2186.6392045312505;2205.106931692651;2211.3587059752654;2213.6679498075255;16874;17446.738298925527;17634;17723.911380443016;17963;1874.9906250468796;2025.8278046366077;2083.916643334265;2116.6824976253683;2130.968035479469;131581.02628460582;132345;132469.99999999904;132799.33600332032;134379;11583.76832463363;11908.940455297841;11934.985526230368;11966.64100076999;12037.638870833889;13102.606921792361;15743.44897928567;15775.605609859616;15776.76334854978;15792;8544.060153383123;8739.868901966476;8747.737567872973;8770.693025744069;8891.510966896883;8226.177382261725;8278.668853245923;8418.579071046546;8423.578821058922;8449.070602233749;6132.386761323921;6145.692715364214;7296.379807716404;7437.405007599379;7437.553746775211;1742.87799854009;2050.9692354614695;2060.681164055006;2061.7732049474544;2082.1688093907283;962.2061799015839;987.2003677021636;992.3202606214766;1036.8341065429645;1040.812653722322;18309.63380732378;18741.625167496575;19819.603607927762;20036.39890803278;21030.369088927357;1002.5238011944268;1018.3126389686931;1034.7826956339102;1036.5076588620345;1041.7446976393428;10474.738131546772;10819.621313253998;10853.34879907208;10864.293820901616;10873.83689244662;482451;518661;553307;557155;557688;107617;119335.20997185049;119500.40249798696;124007;125086;1125.352922069813;1168.5325869652038;1216.3431746856775;1224.6081253998634;1227.9324637145044;21299.574008520052;22083.33749987503;22285.665715014613;22334.21830235934;22338.88305584747;51817;53032.73483632557;53210.935781284934;53568;53905.46094539004;54165.729171353894;75238;76714;77056.68829935111;77853.61073194824;8303;8388.790280243044;8641.697540586048;8867.201951824367;8890.777730556529;13253.734925301247;13332.86667133355;13441.865581344453;13736.381862815997;13755.518556850462;11461.48423320936;11561.88438115608;11773.117016223989;11892.989095926598;11953.908066088226;10605.310654807412;10906.563737450731;10908.072813810915;10921.344719316867;11016.339019658846;11674.70813229676;11835.82246266324;11944.701382465508;12013.699657508632;12064.698382540506;8383.790405239917;8509.404341696021;8542.103079176597;8559.529225892637;8598.742037738877;11307.095432365555;11534.59628912984;11834.230774999598;11966.700832479257;11991.22057066288 09:52:09 INFO - PID 1657 | |3;mootools.html;1154.884511548845;1417.2417756500267;1433.7132573485299;1437.0874494695865;1445;11099.500522476497;11622.128340374484;11626.941865290672;11635.301881887093;11636.418179091042;10932.289401188937;11476.71308217293;11535;11542.961133497984;11553.65339039828;2491.58888783351;2528.190978886757;2534.7465253474597;2535.2267558394683;2536.7336429674897;2108.68369744538;2119.682047692843;2374.988125059372;2514.53481105996;2517.559427100259;2148.205164089289;2168.718066651341;2362.8582285062867;2519.4583164619603;2523.873806309686;2505.686789151356;2506.1854897158314;2510.635957786129;2514.4719608882156;2515.0819950717946;2456.520978409211;2462.667539882129;2485.6768620079456;2501.512205119984;2512.0830896722564;11444.942775286154;11545.422728863607;11560.075193984545;11578.76842463146;11589.420528973518;6501.47988160946;6753.696083676246;6755.088063111466;6756.966215168942;6758.763443279461;4022.2357752027315;4154.543000269968;4310.80601372939;4391.8682439526865;4397.604215620578;1251.455616806692;1271.4801976546908;1272.8854403103674;1279.6691440901545;1299.7010687541824;16372.426965056286;16472.83527164737;16510.587235319093;16512.25694843735;16516.339346426128;5313.203019547099;5464.18037294409;5468.316460442445;5558.305211848519;5604.103343465107;11464.94267528657;11647.30116193031;11648.88351116495;11653.18427710069;11666.824997625043;6467.741290348427;6494.9675251624385;6499.642519661369;6503.804885853432;6527.934720652827;5972.163897054415;6136.969315153396;6186.072089186658;6193.907091393633;6264.091706702503;3581.659742324475;4175.603317684815;4277.732801615149;4305.956940430556;4399.098184872158;1248.1450206608502;1254.1534464236604;1255.2782150263636;1273.5924504158581;1277.8211050452944;769.9538027718355;791.5092642561649;796.4424902568226;798.8841617965362;801.9278264956182;6560.819052570583;6871.553349032397;6936.028955946172;6937.479689023344;6984.016505506039;787.8266781308103;810.7284059840019;935.4293880732747;944.9952750236205;961.110972350573;3624.8006359649944;3783.2055268393397;3836.884893453145;3842.3275926712713;3895.8052097395016;12460.563880264328;14247.928760356132;14701;14746.778798318033;14890;13859.23774192409;14172.929135354463;14454.85545144556;14959.551213463614;14966.551003469913;8447;8496.065432802387;8578.699745509002;8611.78470538229;8627.266682331947;6659.600423974577;6682.398584127257;6706;6727.2263689674355;6789.89815152783;13108.2135071896;13113.213207207598;13217.669558261121;13264.204147751167;13299.135556188818;13484.797728034284;13560.525381611596;13596;13892.166470011427;13894.374753135931;8092.231238032377;8154.551499667576;8169.305609023062;8306.501609903426;8315.958420208102;10435.739106522398;10550.050495455445;10558.736031599272;10561.20790940698;10569.312994655324;8768.473891566526;9058.456492610465;9084.454932704059;9100.135487128713;9150.313726470407;8786.297096232414;8811.206991370807;8897.377183597346;8900.109989001307;8955.41789783662;8185.672573097009;8232.876506852523;8357.66569337244;8358.958205208935;8371.497710137168;6004.832963802631;6010;6150.661713605795;6230.158928544589;6273.309935906956;5952.821415357546;6105.328413874381;6216.502679785516;6270.965290726979;6344.837215332606 09:52:09 INFO - PID 1657 | |4;prototype.html;356.34076957628406;383.21632262024156;397.0867005886461;407.6575676431795;409.3041828890885;5392.703401312926;5653.236813030239;5707.885842283163;5713.771449142029;5717.34250561185;5746.712664366786;5887.970560147193;5905.608228667385;5909.527237820975;5987;3352.580927384077;4389.429374181352;4552.863414097583;4555.4533455985165;4584.404027476424;4088.2028004539125;4266.445362102922;4332.176886391591;4334.826606935719;4355.998120432302;4100.405441211023;4196.769177695225;4270;4282.464691913511;4283.914321713564;4186.413902053715;4239.215745087154;4282.164977829325;4288.742675439484;4299.247631664446;3217.6460589335156;3494.9825250873837;3663.065918190871;3683.834227459771;3685.281370132825;4690.50749671283;5549.500544950974;5623.465770751772;5785.566082543826;5800.303963524362;4505.490660628693;4777.59390451812;4914.434839993411;5063.1898896176435;5078.974605126988;4933.851984440473;5189.455107213726;6292.842678933018;6337.524685648595;6343.904841427382;4053.3312003519386;4138.475529926743;4166.458360413158;4180.28935081037;4208.431861698662;5725.942740572541;6557.770478033293;6588.93411065888;6631.535792494527;6636.336366363374;4126.649234815014;4190.916181676349;4205.201011807747;4210;4215.768132752667;3512.7892326460496;3685.5577330720484;3726.32926073304;3846.903632464734;4298.591633794785;4822.614190864792;5035.892103737172;5040.445550989388;5075.670081444694;5085.237214417867;4759;5203.985222881502;5360.91958620621;5924;6222;1228.65597632663;1434.8421673615894;1457.5117335692662;1458.5332693537966;1459.8613131752466;839.3495041342886;911.6672414568635;932.8787257656597;949.5632009275672;960.3181740963854;5932.525397968152;5996.331632423617;6012.579119461596;6029.246344206974;6045.969770151209;6294;6425.453836423862;6425.903611445832;6576.046473261446;6605.867882642417;4937.950620493821;5894.616849904743;6024.819255422344;6038.335783063947;6184.350643182401;2557.7108487903224;2598.7271336509393;3200.0879749271344;3376.392249395083;3389.322135572846;6512.990486474604;6723.899141512881;6782.355676210752;6787.389134977876;6827.624480653512;5994.6403215807195;6289.930711778917;6628.436582890508;6649.501287403464;6708;5709.400512946164;6506.31683673217;6700.090474214923;6704.296048914891;6752.696128674123;6151.292601350723;6459.928955769886;6466.960528551574;6536.705848236936;6550.853600619777;5395.406505284337;5928.79249226275;6239;6421.454176395058;6497.31778163305;6747.2915343890145;6754.020667003158;6757.290484499254;6773.306673331667;6793.214781939381;3685.931079986774;4196.307609244563;4237.216115018731;4248.617624413818;4250.511191212926;5788.334341550775;6215.65813880241;6498.707558159799;6537.934620653733;6601.840840270599;5179.40436849752;6360.586561873463;6379.744810207725;6402.455791257796;6428.453581445629;4983.72589507566;5269.920951185812;6305.5901366411035;6370.649614271074;6427.343937335302;5366.490183432567;6208.161898143873;6245.375462453719;6284.874302514016;6297.370262973849;5806.258122563129;6292.717300783952;6349.238091428873;6386.521010924106;6409.4231519163495;5375.113106337567;5987.874304621971;6134.202553667995;6166.81499555014;6209.906851397323 09:52:09 INFO - PID 1657 | |5;yui.html;705.8059033765717;844.9577521123946;849.0405841399217;852.8635418333066;861.7716305179129;12881.677958051054;17443.47669569912;17614.943103413803;18690.626187476275;18727.812721872793;14519.419223231058;17316.913415432937;17880.28478860844;17898;17919.73120403195;971.2521358553892;988.5946761827652;989.6091044037637;989.7030890732788;1000.7848312612787;660.6795704083515;678.5826716569298;1003.0270637481631;1007.4559737741611;1008.606643409071;996.623054016173;1003.0070230471816;1005.8239808033602;1006.0894890124449;1035.7928414317166;990.128686755654;995.7610173558367;999.0359303272377;999.1157825324567;1033.824249877519;739.1499775258442;739.2385842582149;739.903812504371;749.3967356278193;769.9307062364414;16310.592235194097;16707.66584668312;16840.663186736198;16918.577035574086;17212.22544985466;16889.43985124022;16948.576285592837;17087.91456042724;17349.95900245989;17404.1297935104;13762.105463144864;13922.721545569133;13965.441382344694;14090.2954852258;14105.36525856339;3387.2040070583394;3409.880654177092;3412.4540073588355;3414.641462646436;3415.163284995167;105644;117945;119345;119827;126528.36735816262;10775.78448431027;11889.940550297366;12026.398680065962;12034.699132521757;12040.578579749666;17491.387801427143;19853.205871764967;25112.623310650353;25465.981360745733;25473.490530189294;7601.885971710429;7878.527288362717;7888.32949199313;7889.763307100796;7902.68389264423;3888.3972984187494;3968.3650615901893;3973.6423721864594;3974.423708562242;3976.403539469045;4220.936685949713;4282.700210985201;4344.391785150082;4349.521552629209;4356.760378179167;825.4098319701442;857.9828403432022;860.5654144656908;861.9353548483889;864.9740507784777;643.2474005413677;678.281022116558;681.1383599746325;687.161662771418;699.797058852927;10623.628173013907;11122.666320010412;11564.42177891102;12087.516499339928;12181.878181218075;648.7145655911384;661.1438187547138;663.7477758451757;667.2360147630935;684.1755684400285;4913.459519452857;4956.405231372259;4977.90044199114;4979.4771548987555;5175.482451754794;95338.5233073844;95845.52077239708;96662.51668741752;96736;98802;84392.15607843966;85147.7227841583;85392.71910921342;85994.57002714946;86110;73606.63196683982;74009;74017.62991185117;74108.51782964419;75940;9349.736379613303;9980.850287245843;10156.035176658206;10161.409389278113;10199.184065274612;40217.29415153018;40401.39397908975;40721.592784072964;41425;41492.585074150076;52144.478555213966;52278.95442091061;52403.68990775261;52699.47300526946;52832;14057.22685252321;14168.858311417167;14240.287985600886;14459.13245205291;14551.92724036373;15058.096514209183;15142.394304227708;15376.461823836113;15550.611234719223;15627.45303914403;14512.492062778174;14647;14877.702445951238;14913.328900199735;15013.849861501682;13681.931590341985;14210.644733881736;14304.928475357556;14313.713725725636;14390.28048597545;14488.710225795214;14851.702965940836;15299.694006119593;16414.343426263295;16463.753043704113;10023.498825058572;11669.59156429521;11816.645500634995;12027.338496382783;12230.816537751763;10550.419726914786;11902.869227423382;12994.285314307426;13176;13359.599212023655 09:52:09 INFO - PID 1657 | __end_tp_report 09:52:09 INFO - PID 1657 | __start_cc_report 09:52:09 INFO - PID 1657 | _x_x_mozilla_cycle_collect,1843 09:52:09 INFO - PID 1657 | __end_cc_report 09:52:09 INFO - PID 1657 | __startTimestamp1493571129725__endTimestamp 09:52:09 INFO - PID 1657 | 09:52:09 INFO - PID 1657 | ------- Summary: start ------- 09:52:09 INFO - PID 1657 | Number of tests: 6 09:52:09 INFO - PID 1657 | 09:52:09 INFO - PID 1657 | [#0] dojo.html Cycles:165 Average:5970.09 Median:6274.62 stddev:691.83 (11.0%) stddev-sans-first:666.07 09:52:09 INFO - PID 1657 | Values: 3491.4 3491.5 3501.8 3513.5 3551.8 4519.7 6054.8 6138.8 6176.4 6202.3 6096.1 6109.1 6148.3 6155.8 6160.8 5099.5 5183.2 5248.6 5274.4 5275.7 5312.2 5364.0 5386.3 5387.5 5425.5 5203.0 5266.8 5273.1 5314.3 5316.0 5301.9 5336.5 5364.7 5378.0 5393.3 5238.5 5267.2 5276.3 5285.2 5286.0 5931.1 6117.9 6136.2 6144.8 6169.3 6404.3 6411.6 6413.7 6455.5 6461.3 6531.8 6536.5 6540.0 6558.0 6575.8 6184.6 6191.8 6249.3 6250.9 6285.3 6404.5 6474.4 6475.6 6669.2 6674.3 6314.1 6347.6 6362.0 6384.8 6391.8 6450.1 6505.3 6505.4 6511.5 6512.6 6420.6 6428.3 6428.4 6429.2 6432.0 6319.1 6382.9 6387.6 6435.1 6436.5 5175.4 5177.7 5182.6 5188.3 5203.4 4491.5 4576.0 4667.5 4675.2 4701.3 4927.6 5891.6 5987.3 6141.0 6156.4 6399.7 6404.9 6486.9 6520.2 6536.4 6145.8 6152.9 6161.8 6164.5 6176.4 5653.2 5685.6 5697.6 5699.0 5723.7 6437.8 6494.3 6595.7 6695.0 6705.7 6373.4 6402.3 6406.7 6407.2 6409.4 5537.4 6146.7 6621.6 6648.7 6685.9 6393.0 6400.1 6416.8 6419.6 6425.7 6492.5 6502.8 6505.8 6531.1 6541.2 6258.2 6332.9 6353.8 6359.0 6364.1 6316.3 6355.1 6358.0 6359.5 6373.9 5286.3 6274.6 6324.3 6326.6 6331.7 6127.1 6171.7 6287.9 6354.2 6363.2 6217.8 6271.9 6301.7 6309.4 6335.0 09:52:09 INFO - PID 1657 | 09:52:09 INFO - PID 1657 | [#1] ext.html Cycles:180 Average:43341.49 Median:34018.74 stddev:74998.93 (220.5%) stddev-sans-first:75141.14 09:52:09 INFO - PID 1657 | Values: 748.8 795.3 801.8 1136.4 1142.1 26317.2 36642.1 37168.3 37210.7 37264.8 38616.6 38817.8 38953.0 38966.8 38977.4 6004.1 8345.9 8517.8 8520.5 8531.0 5995.3 7534.4 8444.6 8464.0 8482.1 8499.8 8542.3 8544.1 8548.8 8611.6 5930.6 8476.7 8506.7 8517.7 8537.0 5950.1 8130.4 8286.0 8294.3 8302.5 37073.4 37239.8 37363.3 37366.6 37446.0 3567.1 3610.2 3612.1 3614.0 3614.6 30304.7 30332.4 30347.9 30393.7 30396.5 3111.8 3176.5 3191.4 3194.5 3206.2 281211.6 289491.6 289570.0 290261.0 291038.0 47421.3 47592.0 47596.5 47635.5 47636.0 50831.5 50978.0 51009.0 51029.0 51170.5 13941.2 13997.8 14010.4 14013.2 14015.4 9840.8 11329.4 11333.9 11350.8 11354.8 8776.0 8877.6 10760.7 10842.8 10872.6 5283.8 5508.7 5527.5 5546.5 5563.7 1035.0 1038.6 1040.6 1072.7 1075.1 23153.0 24204.5 24271.4 24310.9 24347.1 1135.9 1137.6 1177.2 1183.4 1185.1 12424.8 12447.3 12447.3 12448.6 12454.6 298757.0 299090.0 299269.0 299336.0 299460.0 53323.5 53586.0 53673.0 53715.7 53744.0 1519.5 1543.0 1584.6 1590.5 1591.9 21397.9 21680.0 21818.6 23850.4 23907.0 37622.0 37625.4 37646.6 37686.4 37735.2 269759.0 269879.0 270103.0 270159.0 270459.0 34008.7 34028.8 34073.7 34084.8 34097.7 35656.1 36464.8 41432.8 42831.6 43547.1 27817.6 28923.0 29717.0 29772.3 30241.5 27202.7 29307.9 29888.3 30067.8 30691.8 34765.7 35805.7 35899.8 35936.6 36003.6 28371.3 29016.0 30085.5 30160.2 30213.1 19905.3 20565.5 23415.0 23612.6 23693.6 09:52:09 INFO - PID 1657 | 09:52:09 INFO - PID 1657 | [#2] jquery.html Cycles:180 Average:33714.71 Median:21962.62 stddev:89901.43 (409.3%) stddev-sans-first:90118.78 09:52:09 INFO - PID 1657 | Values: 376.6 397.3 413.9 437.8 446.4 12724.8 14651.2 21032.0 21193.7 21368.4 21958.2 22041.4 22710.2 22963.3 22986.4 5022.8 5889.3 6017.6 6086.4 6095.4 3571.4 3625.6 5906.9 6068.1 6068.6 5751.5 6040.3 6079.4 6087.4 6102.1 5780.9 5971.1 6016.0 6062.0 6073.4 5336.5 5339.8 5340.8 5344.3 5350.1 21967.0 26185.7 27100.1 27142.7 27510.9 2162.6 2186.6 2205.1 2211.4 2213.7 16874.0 17446.7 17634.0 17723.9 17963.0 1875.0 2025.8 2083.9 2116.7 2131.0 131581.0 132345.0 132470.0 132799.3 134379.0 11583.8 11908.9 11935.0 11966.6 12037.6 13102.6 15743.4 15775.6 15776.8 15792.0 8544.1 8739.9 8747.7 8770.7 8891.5 8226.2 8278.7 8418.6 8423.6 8449.1 6132.4 6145.7 7296.4 7437.4 7437.6 1742.9 2051.0 2060.7 2061.8 2082.2 962.2 987.2 992.3 1036.8 1040.8 18309.6 18741.6 19819.6 20036.4 21030.4 1002.5 1018.3 1034.8 1036.5 1041.7 10474.7 10819.6 10853.3 10864.3 10873.8 482451.0 518661.0 553307.0 557155.0 557688.0 107617.0 119335.2 119500.4 124007.0 125086.0 1125.4 1168.5 1216.3 1224.6 1227.9 21299.6 22083.3 22285.7 22334.2 22338.9 51817.0 53032.7 53210.9 53568.0 53905.5 54165.7 75238.0 76714.0 77056.7 77853.6 8303.0 8388.8 8641.7 8867.2 8890.8 13253.7 13332.9 13441.9 13736.4 13755.5 11461.5 11561.9 11773.1 11893.0 11953.9 10605.3 10906.6 10908.1 10921.3 11016.3 11674.7 11835.8 11944.7 12013.7 12064.7 8383.8 8509.4 8542.1 8559.5 8598.7 11307.1 11534.6 11834.2 11966.7 11991.2 09:52:09 INFO - PID 1657 | 09:52:09 INFO - PID 1657 | [#3] mootools.html Cycles:180 Average:7009.73 Median:3603.23 stddev:4415.71 (122.5%) stddev-sans-first:4406.17 09:52:09 INFO - PID 1657 | Values: 1154.9 1417.2 1433.7 1437.1 1445.0 11099.5 11622.1 11626.9 11635.3 11636.4 10932.3 11476.7 11535.0 11543.0 11553.7 2491.6 2528.2 2534.7 2535.2 2536.7 2108.7 2119.7 2375.0 2514.5 2517.6 2148.2 2168.7 2362.9 2519.5 2523.9 2505.7 2506.2 2510.6 2514.5 2515.1 2456.5 2462.7 2485.7 2501.5 2512.1 11444.9 11545.4 11560.1 11578.8 11589.4 6501.5 6753.7 6755.1 6757.0 6758.8 4022.2 4154.5 4310.8 4391.9 4397.6 1251.5 1271.5 1272.9 1279.7 1299.7 16372.4 16472.8 16510.6 16512.3 16516.3 5313.2 5464.2 5468.3 5558.3 5604.1 11464.9 11647.3 11648.9 11653.2 11666.8 6467.7 6495.0 6499.6 6503.8 6527.9 5972.2 6137.0 6186.1 6193.9 6264.1 3581.7 4175.6 4277.7 4306.0 4399.1 1248.1 1254.2 1255.3 1273.6 1277.8 770.0 791.5 796.4 798.9 801.9 6560.8 6871.6 6936.0 6937.5 6984.0 787.8 810.7 935.4 945.0 961.1 3624.8 3783.2 3836.9 3842.3 3895.8 12460.6 14247.9 14701.0 14746.8 14890.0 13859.2 14172.9 14454.9 14959.6 14966.6 8447.0 8496.1 8578.7 8611.8 8627.3 6659.6 6682.4 6706.0 6727.2 6789.9 13108.2 13113.2 13217.7 13264.2 13299.1 13484.8 13560.5 13596.0 13892.2 13894.4 8092.2 8154.6 8169.3 8306.5 8316.0 10435.7 10550.1 10558.7 10561.2 10569.3 8768.5 9058.5 9084.5 9100.1 9150.3 8786.3 8811.2 8897.4 8900.1 8955.4 8185.7 8232.9 8357.7 8359.0 8371.5 6004.8 6010.0 6150.7 6230.2 6273.3 5952.8 6105.3 6216.5 6271.0 6344.8 09:52:09 INFO - PID 1657 | 09:52:09 INFO - PID 1657 | [#4] prototype.html Cycles:180 Average:5031.69 Median:5721.64 stddev:1629.81 (28.5%) stddev-sans-first:1596.16 09:52:09 INFO - PID 1657 | Values: 356.3 383.2 397.1 407.7 409.3 5392.7 5653.2 5707.9 5713.8 5717.3 5746.7 5888.0 5905.6 5909.5 5987.0 3352.6 4389.4 4552.9 4555.5 4584.4 4088.2 4266.4 4332.2 4334.8 4356.0 4100.4 4196.8 4270.0 4282.5 4283.9 4186.4 4239.2 4282.2 4288.7 4299.2 3217.6 3495.0 3663.1 3683.8 3685.3 4690.5 5549.5 5623.5 5785.6 5800.3 4505.5 4777.6 4914.4 5063.2 5079.0 4933.9 5189.5 6292.8 6337.5 6343.9 4053.3 4138.5 4166.5 4180.3 4208.4 5725.9 6557.8 6588.9 6631.5 6636.3 4126.6 4190.9 4205.2 4210.0 4215.8 3512.8 3685.6 3726.3 3846.9 4298.6 4822.6 5035.9 5040.4 5075.7 5085.2 4759.0 5204.0 5360.9 5924.0 6222.0 1228.7 1434.8 1457.5 1458.5 1459.9 839.3 911.7 932.9 949.6 960.3 5932.5 5996.3 6012.6 6029.2 6046.0 6294.0 6425.5 6425.9 6576.0 6605.9 4938.0 5894.6 6024.8 6038.3 6184.4 2557.7 2598.7 3200.1 3376.4 3389.3 6513.0 6723.9 6782.4 6787.4 6827.6 5994.6 6289.9 6628.4 6649.5 6708.0 5709.4 6506.3 6700.1 6704.3 6752.7 6151.3 6459.9 6467.0 6536.7 6550.9 5395.4 5928.8 6239.0 6421.5 6497.3 6747.3 6754.0 6757.3 6773.3 6793.2 3685.9 4196.3 4237.2 4248.6 4250.5 5788.3 6215.7 6498.7 6537.9 6601.8 5179.4 6360.6 6379.7 6402.5 6428.5 4983.7 5269.9 6305.6 6370.6 6427.3 5366.5 6208.2 6245.4 6284.9 6297.4 5806.3 6292.7 6349.2 6386.5 6409.4 5375.1 5987.9 6134.2 6166.8 6209.9 09:52:09 INFO - PID 1657 | 09:52:09 INFO - PID 1657 | [#5] yui.html Cycles:180 Average:20439.54 Median:25469.74 stddev:28596.26 (112.3%) stddev-sans-first:28638.09 09:52:09 INFO - PID 1657 | Values: 705.8 845.0 849.0 852.9 861.8 12881.7 17443.5 17614.9 18690.6 18727.8 14519.4 17316.9 17880.3 17898.0 17919.7 971.3 988.6 989.6 989.7 1000.8 660.7 678.6 1003.0 1007.5 1008.6 996.6 1003.0 1005.8 1006.1 1035.8 990.1 995.8 999.0 999.1 1033.8 739.1 739.2 739.9 749.4 769.9 16310.6 16707.7 16840.7 16918.6 17212.2 16889.4 16948.6 17087.9 17350.0 17404.1 13762.1 13922.7 13965.4 14090.3 14105.4 3387.2 3409.9 3412.5 3414.6 3415.2 105644.0 117945.0 119345.0 119827.0 126528.4 10775.8 11889.9 12026.4 12034.7 12040.6 17491.4 19853.2 25112.6 25466.0 25473.5 7601.9 7878.5 7888.3 7889.8 7902.7 3888.4 3968.4 3973.6 3974.4 3976.4 4220.9 4282.7 4344.4 4349.5 4356.8 825.4 858.0 860.6 861.9 865.0 643.2 678.3 681.1 687.2 699.8 10623.6 11122.7 11564.4 12087.5 12181.9 648.7 661.1 663.7 667.2 684.2 4913.5 4956.4 4977.9 4979.5 5175.5 95338.5 95845.5 96662.5 96736.0 98802.0 84392.2 85147.7 85392.7 85994.6 86110.0 73606.6 74009.0 74017.6 74108.5 75940.0 9349.7 9980.9 10156.0 10161.4 10199.2 40217.3 40401.4 40721.6 41425.0 41492.6 52144.5 52279.0 52403.7 52699.5 52832.0 14057.2 14168.9 14240.3 14459.1 14551.9 15058.1 15142.4 15376.5 15550.6 15627.5 14512.5 14647.0 14877.7 14913.3 15013.8 13681.9 14210.6 14304.9 14313.7 14390.3 14488.7 14851.7 15299.7 16414.3 16463.8 10023.5 11669.6 11816.6 12027.3 12230.8 10550.4 11902.9 12994.3 13176.0 13359.6 09:52:09 INFO - PID 1657 | -------- Summary: end -------- 09:52:09 INFO - PID 1657 | 09:52:10 INFO - TEST-INFO | 1657: exit 0 09:52:10 INFO - TEST-OK | dromaeo_css | took 1119410ms 09:52:10 INFO - TEST-START | kraken 09:52:10 INFO - operating with platform_type : mac_ 09:52:10 INFO - Initialising browser for kraken test... 09:52:10 INFO - TEST-INFO | started process 1666 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpzhmLbo/profile http://localhost:49239/getInfo.html) 09:52:12 INFO - PID 1666 | __metrics Screen width/height:1600/1200 09:52:12 INFO - PID 1666 | colorDepth:24 09:52:12 INFO - PID 1666 | Browser inner width/height: 1024/689 09:52:12 INFO - PID 1666 | __metrics 09:52:12 INFO - PID 1666 | 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" 09:52:12 INFO - PID 1666 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 09:52:13 INFO - TEST-INFO | 1666: exit 0 09:52:13 INFO - Browser initialized. 09:52:13 INFO - Running cycle 1/1 for kraken test... 09:52:13 INFO - TEST-INFO | started process 1667 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/tmpzhmLbo/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 09:52:25 INFO - PID 1667 | RSS: Main: 241020928 09:52:25 INFO - PID 1667 | 09:52:28 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection) 09:52:29 INFO - PID 1667 | RSS: Main: 310382592 09:52:29 INFO - PID 1667 | 09:52:32 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-dft) 09:52:32 INFO - PID 1667 | RSS: Main: 294817792 09:52:32 INFO - PID 1667 | 09:52:35 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-fft) 09:52:36 INFO - PID 1667 | RSS: Main: 387530752 09:52:36 INFO - PID 1667 | 09:52:38 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator) 09:52:39 INFO - PID 1667 | RSS: Main: 290729984 09:52:39 INFO - PID 1667 | 09:52:41 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur) 09:52:42 INFO - PID 1667 | RSS: Main: 293404672 09:52:42 INFO - PID 1667 | 09:52:44 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom) 09:52:45 INFO - PID 1667 | RSS: Main: 356466688 09:52:45 INFO - PID 1667 | 09:52:48 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate) 09:52:49 INFO - PID 1667 | RSS: Main: 370593792 09:52:49 INFO - PID 1667 | 09:52:52 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial) 09:52:52 INFO - PID 1667 | RSS: Main: 373477376 09:52:52 INFO - PID 1667 | 09:52:54 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox) 09:52:54 INFO - PID 1667 | RSS: Main: 330907648 09:52:54 INFO - PID 1667 | 09:52:56 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes) 09:52:57 INFO - PID 1667 | RSS: Main: 332910592 09:52:57 INFO - PID 1667 | 09:52:59 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm) 09:53:00 INFO - PID 1667 | RSS: Main: 315772928 09:53:00 INFO - PID 1667 | 09:53:03 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 09:53:03 INFO - PID 1667 | RSS: Main: 332308480 09:53:03 INFO - PID 1667 | 09:53:07 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 09:53:07 INFO - PID 1667 | RSS: Main: 342859776 09:53:07 INFO - PID 1667 | 09:53:09 INFO - PID 1667 | Cycle 1(1): loaded http://localhost:49239/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49239/tests/kraken/driver.html?testName=ai-astar) 09:53:09 INFO - PID 1667 | RSS: Main: 386220032 09:53:09 INFO - PID 1667 | 09:53:09 INFO - PID 1667 | __start_tp_report 09:53:09 INFO - PID 1667 | _x_x_mozilla_page_load 09:53:09 INFO - PID 1667 | _x_x_mozilla_page_load_details 09:53:09 INFO - PID 1667 | |i|pagename|runs| 09:53:09 INFO - PID 1667 | |0;ai-astar;110;110;108;108;108;110;109;110;108;110 09:53:09 INFO - PID 1667 | |1;audio-beat-detection;133;109;107;144;102;106;106;107;133;109 09:53:09 INFO - PID 1667 | |2;audio-dft;186;187;183;182;187;185;185;185;186;182 09:53:09 INFO - PID 1667 | |3;audio-fft;81;63;75;113;52;79;82;82;80;58 09:53:09 INFO - PID 1667 | |4;audio-oscillator;132;69;86;94;101;103;105;67;69;111 09:53:09 INFO - PID 1667 | |5;imaging-gaussian-blur;90;86;90;89;89;88;88;89;89;90 09:53:09 INFO - PID 1667 | |6;imaging-darkroom;95;96;96;96;94;95;96;95;116;146 09:53:09 INFO - PID 1667 | |7;imaging-desaturate;86;98;130;88;84;84;86;84;85;86 09:53:09 INFO - PID 1667 | |8;json-parse-financial;48;47;47;46;48;47;50;48;47;47 09:53:09 INFO - PID 1667 | |9;json-stringify-tinderbox;57;65;67;53;61;60;56;56;56;56 09:53:09 INFO - PID 1667 | |10;stanford-crypto-aes;83;83;81;81;86;95;95;94;104;106 09:53:09 INFO - PID 1667 | |11;stanford-crypto-ccm;137;137;162;135;135;136;136;142;194;135 09:53:09 INFO - PID 1667 | |12;stanford-crypto-pbkdf2;186;188;215;182;183;189;234;203;182;185 09:53:09 INFO - PID 1667 | |13;stanford-crypto-sha256-iterative;69;70;73;94;94;94;75;69;69;69 09:53:09 INFO - PID 1667 | __end_tp_report 09:53:09 INFO - PID 1667 | __start_cc_report 09:53:09 INFO - PID 1667 | _x_x_mozilla_cycle_collect,2199 09:53:09 INFO - PID 1667 | __end_cc_report 09:53:09 INFO - PID 1667 | __startTimestamp1493571189807__endTimestamp 09:53:09 INFO - PID 1667 | 09:53:09 INFO - PID 1667 | ------- Summary: start ------- 09:53:09 INFO - PID 1667 | Number of tests: 14 09:53:09 INFO - PID 1667 | 09:53:09 INFO - PID 1667 | [#0] ai-astar Cycles:10 Average:109.10 Median:110.00 stddev:0.99 (0.9%) stddev-sans-first:1.00 09:53:09 INFO - PID 1667 | Values: 110.0 110.0 108.0 108.0 108.0 110.0 109.0 110.0 108.0 110.0 09:53:09 INFO - PID 1667 | 09:53:09 INFO - PID 1667 | [#1] audio-beat-detection Cycles:10 Average:115.60 Median:109.00 stddev:14.97 (13.7%) stddev-sans-first:14.49 09:53:09 INFO - PID 1667 | Values: 133.0 109.0 107.0 144.0 102.0 106.0 106.0 107.0 133.0 109.0 09:53:09 INFO - PID 1667 | 09:53:09 INFO - PID 1667 | [#2] audio-dft Cycles:10 Average:184.80 Median:185.50 stddev:1.87 (1.0%) stddev-sans-first:1.94 09:53:09 INFO - PID 1667 | Values: 186.0 187.0 183.0 182.0 187.0 185.0 185.0 185.0 186.0 182.0 09:53:09 INFO - PID 1667 | 09:53:09 INFO - PID 1667 | [#3] audio-fft Cycles:10 Average:76.50 Median:79.50 stddev:16.86 (21.2%) stddev-sans-first:17.80 09:53:09 INFO - PID 1667 | Values: 81.0 63.0 75.0 113.0 52.0 79.0 82.0 82.0 80.0 58.0 09:53:09 INFO - PID 1667 | 09:53:09 INFO - PID 1667 | [#4] audio-oscillator Cycles:10 Average:93.70 Median:68.00 stddev:21.15 (31.1%) stddev-sans-first:17.31 09:53:09 INFO - PID 1667 | Values: 132.0 69.0 86.0 94.0 101.0 103.0 105.0 67.0 69.0 111.0 09:53:09 INFO - PID 1667 | 09:53:09 INFO - PID 1667 | [#5] imaging-gaussian-blur Cycles:10 Average:88.80 Median:89.00 stddev:1.23 (1.4%) stddev-sans-first:1.22 09:53:09 INFO - PID 1667 | Values: 90.0 86.0 90.0 89.0 89.0 88.0 88.0 89.0 89.0 90.0 09:53:09 INFO - PID 1667 | 09:53:09 INFO - PID 1667 | [#6] imaging-darkroom Cycles:10 Average:102.50 Median:95.50 stddev:16.61 (17.4%) stddev-sans-first:17.40 09:53:09 INFO - PID 1667 | Values: 95.0 96.0 96.0 96.0 94.0 95.0 96.0 95.0 116.0 146.0 09:53:09 INFO - PID 1667 | 09:53:09 INFO - PID 1667 | [#7] imaging-desaturate Cycles:10 Average:91.10 Median:86.00 stddev:14.29 (16.6%) stddev-sans-first:15.03 09:53:09 INFO - PID 1667 | Values: 86.0 98.0 130.0 88.0 84.0 84.0 86.0 84.0 85.0 86.0 09:53:09 INFO - PID 1667 | 09:53:09 INFO - PID 1667 | [#8] json-parse-financial Cycles:10 Average:47.50 Median:47.50 stddev:1.08 (2.3%) stddev-sans-first:1.13 09:53:09 INFO - PID 1667 | Values: 48.0 47.0 47.0 46.0 48.0 47.0 50.0 48.0 47.0 47.0 09:53:09 INFO - PID 1667 | 09:53:09 INFO - PID 1667 | [#9] json-stringify-tinderbox Cycles:10 Average:58.70 Median:58.50 stddev:4.47 (7.6%) stddev-sans-first:4.70 09:53:09 INFO - PID 1667 | Values: 57.0 65.0 67.0 53.0 61.0 60.0 56.0 56.0 56.0 56.0 09:53:09 INFO - PID 1667 | 09:53:09 INFO - PID 1667 | [#10] stanford-crypto-aes Cycles:10 Average:90.80 Median:84.50 stddev:9.35 (11.1%) stddev-sans-first:9.49 09:53:09 INFO - PID 1667 | Values: 83.0 83.0 81.0 81.0 86.0 95.0 95.0 94.0 104.0 106.0 09:53:09 INFO - PID 1667 | 09:53:09 INFO - PID 1667 | [#11] stanford-crypto-ccm Cycles:10 Average:144.90 Median:137.00 stddev:19.12 (14.0%) stddev-sans-first:20.06 09:53:09 INFO - PID 1667 | Values: 137.0 137.0 162.0 135.0 135.0 136.0 136.0 142.0 194.0 135.0 09:53:09 INFO - PID 1667 | 09:53:09 INFO - PID 1667 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:194.70 Median:188.50 stddev:17.42 (9.2%) stddev-sans-first:18.19 09:53:09 INFO - PID 1667 | Values: 186.0 188.0 215.0 182.0 183.0 189.0 234.0 203.0 182.0 185.0 09:53:09 INFO - PID 1667 | 09:53:09 INFO - PID 1667 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.60 Median:74.00 stddev:11.49 (15.5%) stddev-sans-first:11.76 09:53:09 INFO - PID 1667 | Values: 69.0 70.0 73.0 94.0 94.0 94.0 75.0 69.0 69.0 69.0 09:53:09 INFO - PID 1667 | -------- Summary: end -------- 09:53:09 INFO - PID 1667 | 09:53:11 INFO - TEST-INFO | 1667: exit 0 09:53:11 INFO - TEST-OK | kraken | took 60701ms 09:53:11 INFO - SUITE-END | took 1180s 09:53:11 INFO - Completed test suite (00:19:40) 09:53:11 INFO - javascript benchmark 09:53:11 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7601.611906119285, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3491.3715531204375, 3491.511188433621, 3501.8249087545614, 3513.490543871139, 3551.8224088795555, 4519.66102542309, 6054.818355449333, 6138.785142520012, 6176.444120029197, 6202.255729312483, 6096.085587161928, 6109.053096769997, 6148.323684394713, 6155.784547540837, 6160.845978850531, 5099.515546023122, 5183.196604526304, 5248.632595718283, 5274.446183150752, 5275.736213189344, 5312.150055991042, 5364.0, 5386.2997810284605, 5387.515123638872, 5425.538829199523, 5203.03743807393, 5266.8419947401635, 5273.077211487975, 5314.335708036515, 5315.963387139509, 5301.867453313659, 5336.466353364672, 5364.678119312854, 5377.973110134463, 5393.325834270716, 5238.528532432061, 5267.157254839246, 5276.261323414725, 5285.207218917155, 5285.973570132163, 5931.139984702194, 6117.938820611781, 6136.20229370179, 6144.815655530341, 6169.321374648785, 6404.327545607691, 6411.6153030818305, 6413.7434502619835, 6455.451286640641, 6461.289258181596, 6531.836704082389, 6536.477081833442, 6539.9673001635165, 6557.967210163966, 6575.769848055295, 6184.56708030438, 6191.84520386994, 6249.312575616678, 6250.937490625081, 6285.277193122758, 6404.519661025442, 6474.352564743582, 6475.643839588868, 6669.1996960364095, 6674.2658307586125, 6314.0844577536, 6347.619142851444, 6362.0, 6384.776532821329, 6391.840203994844, 6450.096986421905, 6505.251896031922, 6505.381988711065, 6511.544191906616, 6512.576682515716, 6420.6468644225015, 6428.260750013808, 6428.421442070143, 6429.196350456193, 6431.970884658525, 6319.146915166394, 6382.904256436157, 6387.648679322682, 6435.099086127946, 6436.452901503425, 5175.430702622783, 5177.689338639693, 5182.5594824439595, 5188.299579556787, 5203.401608814959, 4491.505934347219, 4575.993281478136, 4667.509911459248, 4675.2052151134385, 4701.341812146302, 4927.605791536668, 5891.646501209942, 5987.341392446828, 6141.0, 6156.353582873734, 6399.680015999182, 6404.943184374619, 6486.870262594722, 6520.152380190545, 6536.379043990813, 6145.801568694062, 6152.907706384408, 6161.815145545641, 6164.537659675542, 6176.413240742122, 5653.180288858175, 5685.60200785941, 5697.629654072555, 5699.00267453194, 5723.656580605177, 6437.806865794034, 6494.253160886558, 6595.703193356215, 6694.966525167343, 6705.731770729116, 6373.362663733775, 6402.263739669997, 6406.743730250924, 6407.231132264158, 6409.4231519163495, 5537.446255374431, 6146.678464130234, 6621.569597976116, 6648.700808463534, 6685.866282674417, 6392.968035159981, 6400.135981642605, 6416.7754128605275, 6419.582727122722, 6425.742970281323, 6492.513061520499, 6502.772402965874, 6505.837354066186, 6531.11829902976, 6541.215054193527, 6258.186435763321, 6332.905006425, 6353.809385718436, 6358.968205158944, 6364.07720880479, 6316.273628532594, 6355.1420558224045, 6358.0, 6359.523035772429, 6373.8725225496155, 5286.3392075990505, 6274.623522588659, 6324.335944725737, 6326.55714100027, 6331.715072821642, 6127.128444391353, 6171.722272497838, 6287.874242515216, 6354.205724284465, 6363.236411630449, 6217.844553886189, 6271.937280627318, 6301.716422761078, 6309.400606942333, 6335.049742538656], "value": 5925.942798502505, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [748.8352562436262, 795.272325821873, 801.7714951238896, 1136.4204255829525, 1142.0977427832013, 26317.210483685496, 36642.083947901316, 37168.25663486736, 37210.69762558315, 37264.81367593158, 38616.61383386165, 38817.805910970405, 38953.0, 38966.80516597413, 38977.41533876987, 6004.0693692477735, 8345.91654083459, 8517.829643407129, 8520.488770673748, 8531.0, 5995.280566332046, 7534.397248220157, 8444.619992100339, 8463.984321881351, 8482.109378515228, 8499.830003399928, 8542.316614670843, 8544.102869198738, 8548.82902341956, 8611.56942152893, 5930.584859059867, 8476.66093356265, 8506.702265420681, 8517.701880434186, 8537.0, 5950.077737950582, 8130.430869839113, 8286.047104582989, 8294.294984926288, 8302.501849889026, 37073.443898341546, 37239.81380093109, 37363.25273494542, 37366.62633373686, 37446.0, 3567.0725611341236, 3610.1696609779633, 3612.0608641753333, 3613.963860361389, 3614.638536146391, 30304.69695303041, 30332.393352133055, 30347.937822176118, 30393.696063039308, 30396.54405183924, 3111.797733147338, 3176.4600017996995, 3191.3617276544783, 3194.4888817789274, 3206.2465320649862, 281211.59394203103, 289491.55254223594, 289570.0, 290261.0, 291038.0, 47421.288680669815, 47592.0, 47596.5240347599, 47635.52364476311, 47636.0, 50831.49168508341, 50978.0, 51009.0, 51029.0, 51170.48829511732, 13941.233232172124, 13997.790033149511, 14010.439582416793, 14013.159210447406, 14015.369308381147, 9840.803183936281, 11329.43352832355, 11333.94333028346, 11350.829737553944, 11354.772904541864, 8776.0, 8877.600507977157, 10760.677179684622, 10842.837357439645, 10872.629484859719, 5283.841484755463, 5508.669479831223, 5527.474889885454, 5546.528545073714, 5563.749631266603, 1034.9534270957824, 1038.5638032026416, 1040.6201736366172, 1072.6942821295893, 1075.086176749772, 23153.0, 24204.51590968206, 24271.393215169763, 24310.878445608014, 24347.14784982517, 1135.914806389524, 1137.647329327911, 1177.1759768162322, 1183.402381797204, 1185.0637995983077, 12424.75150496985, 12447.253164810141, 12447.253164810141, 12448.62654120378, 12454.626361209179, 298757.0, 299090.0, 299269.0, 299336.0, 299460.0, 53323.466765332625, 53586.0, 53673.0, 53715.73142134264, 53744.0, 1519.5365413548973, 1542.9739223416302, 1584.619691274109, 1590.506942847721, 1591.8646915012123, 21397.93010349445, 21680.0, 21818.56362872702, 23850.40373990664, 23907.0, 37622.0, 37625.4356184652, 37646.62353376541, 37686.434703478924, 37735.24529509449, 269759.0, 269879.0, 270103.0, 270159.0, 270459.0, 34008.65991340154, 34028.82985585056, 34073.65926340705, 34084.82957585196, 34097.65902340945, 35656.108597285274, 36464.81767591145, 41432.79283603562, 42831.57168428276, 43547.12905741804, 27817.582736259377, 28923.0, 29717.0, 29772.255693606967, 30241.546376803926, 27202.72797272002, 29307.85346073341, 29888.25279368033, 30067.849660751555, 30691.846540767154, 34765.65234347624, 35805.74679886192, 35899.82050089733, 35936.64063359333, 36003.63996360003, 28371.290717732223, 29016.0, 30085.548716769703, 30160.24599385033, 30213.093607190942, 19905.303314383927, 20565.485862853548, 23415.0, 23612.645810312515, 23693.644595330738], "value": 16973.183429452056, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [376.64030850537733, 397.3245482679446, 413.8861813001424, 437.78986086678395, 446.4352593968628, 12724.809127863078, 14651.194184319858, 21032.0, 21193.682094768592, 21368.358949231548, 21958.23146189884, 22041.448963775914, 22710.205142820003, 22963.311100667008, 22986.425339366524, 5022.849314520552, 5889.322727886305, 6017.608855424405, 6086.391360863922, 6095.420935011167, 3571.428571428572, 3625.6374362563797, 5906.852328691795, 6068.059450785136, 6068.605540639866, 5751.511121554673, 6040.275166979968, 6079.422454866803, 6087.360827113156, 6102.145699602059, 5780.855478613026, 5971.104334349839, 6016.037434010537, 6061.969690151565, 6073.362296958822, 5336.466353364672, 5339.813106541253, 5340.759665815009, 5344.305240318772, 5350.0904846176245, 21967.0, 26185.73814261871, 27100.051498197667, 27142.72857271422, 27510.862445687842, 2162.56748650269, 2186.6392045312505, 2205.106931692651, 2211.3587059752654, 2213.6679498075255, 16874.0, 17446.738298925527, 17634.0, 17723.911380443016, 17963.0, 1874.9906250468796, 2025.8278046366077, 2083.916643334265, 2116.6824976253683, 2130.968035479469, 131581.02628460582, 132345.0, 132469.99999999904, 132799.33600332032, 134379.0, 11583.76832463363, 11908.940455297841, 11934.985526230368, 11966.64100076999, 12037.638870833889, 13102.606921792361, 15743.44897928567, 15775.605609859616, 15776.76334854978, 15792.0, 8544.060153383123, 8739.868901966476, 8747.737567872973, 8770.693025744069, 8891.510966896883, 8226.177382261725, 8278.668853245923, 8418.579071046546, 8423.578821058922, 8449.070602233749, 6132.386761323921, 6145.692715364214, 7296.379807716404, 7437.405007599379, 7437.553746775211, 1742.87799854009, 2050.9692354614695, 2060.681164055006, 2061.7732049474544, 2082.1688093907283, 962.2061799015839, 987.2003677021636, 992.3202606214766, 1036.8341065429645, 1040.812653722322, 18309.63380732378, 18741.625167496575, 19819.603607927762, 20036.39890803278, 21030.369088927357, 1002.5238011944268, 1018.3126389686931, 1034.7826956339102, 1036.5076588620345, 1041.7446976393428, 10474.738131546772, 10819.621313253998, 10853.34879907208, 10864.293820901616, 10873.83689244662, 482451.0, 518661.0, 553307.0, 557155.0, 557688.0, 107617.0, 119335.20997185049, 119500.40249798696, 124007.0, 125086.0, 1125.352922069813, 1168.5325869652038, 1216.3431746856775, 1224.6081253998634, 1227.9324637145044, 21299.574008520052, 22083.33749987503, 22285.665715014613, 22334.21830235934, 22338.88305584747, 51817.0, 53032.73483632557, 53210.935781284934, 53568.0, 53905.46094539004, 54165.729171353894, 75238.0, 76714.0, 77056.68829935111, 77853.61073194824, 8303.0, 8388.790280243044, 8641.697540586048, 8867.201951824367, 8890.777730556529, 13253.734925301247, 13332.86667133355, 13441.865581344453, 13736.381862815997, 13755.518556850462, 11461.48423320936, 11561.88438115608, 11773.117016223989, 11892.989095926598, 11953.908066088226, 10605.310654807412, 10906.563737450731, 10908.072813810915, 10921.344719316867, 11016.339019658846, 11674.70813229676, 11835.82246266324, 11944.701382465508, 12013.699657508632, 12064.698382540506, 8383.790405239917, 8509.404341696021, 8542.103079176597, 8559.529225892637, 8598.742037738877, 11307.095432365555, 11534.59628912984, 11834.230774999598, 11966.700832479257, 11991.22057066288], "value": 10045.367237822475, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1154.884511548845, 1417.2417756500267, 1433.7132573485299, 1437.0874494695865, 1445.0, 11099.500522476497, 11622.128340374484, 11626.941865290672, 11635.301881887093, 11636.418179091042, 10932.289401188937, 11476.71308217293, 11535.0, 11542.961133497984, 11553.65339039828, 2491.58888783351, 2528.190978886757, 2534.7465253474597, 2535.2267558394683, 2536.7336429674897, 2108.68369744538, 2119.682047692843, 2374.988125059372, 2514.53481105996, 2517.559427100259, 2148.205164089289, 2168.718066651341, 2362.8582285062867, 2519.4583164619603, 2523.873806309686, 2505.686789151356, 2506.1854897158314, 2510.635957786129, 2514.4719608882156, 2515.0819950717946, 2456.520978409211, 2462.667539882129, 2485.6768620079456, 2501.512205119984, 2512.0830896722564, 11444.942775286154, 11545.422728863607, 11560.075193984545, 11578.76842463146, 11589.420528973518, 6501.47988160946, 6753.696083676246, 6755.088063111466, 6756.966215168942, 6758.763443279461, 4022.2357752027315, 4154.543000269968, 4310.80601372939, 4391.8682439526865, 4397.604215620578, 1251.455616806692, 1271.4801976546908, 1272.8854403103674, 1279.6691440901545, 1299.7010687541824, 16372.426965056286, 16472.83527164737, 16510.587235319093, 16512.25694843735, 16516.339346426128, 5313.203019547099, 5464.18037294409, 5468.316460442445, 5558.305211848519, 5604.103343465107, 11464.94267528657, 11647.30116193031, 11648.88351116495, 11653.18427710069, 11666.824997625043, 6467.741290348427, 6494.9675251624385, 6499.642519661369, 6503.804885853432, 6527.934720652827, 5972.163897054415, 6136.969315153396, 6186.072089186658, 6193.907091393633, 6264.091706702503, 3581.659742324475, 4175.603317684815, 4277.732801615149, 4305.956940430556, 4399.098184872158, 1248.1450206608502, 1254.1534464236604, 1255.2782150263636, 1273.5924504158581, 1277.8211050452944, 769.9538027718355, 791.5092642561649, 796.4424902568226, 798.8841617965362, 801.9278264956182, 6560.819052570583, 6871.553349032397, 6936.028955946172, 6937.479689023344, 6984.016505506039, 787.8266781308103, 810.7284059840019, 935.4293880732747, 944.9952750236205, 961.110972350573, 3624.8006359649944, 3783.2055268393397, 3836.884893453145, 3842.3275926712713, 3895.8052097395016, 12460.563880264328, 14247.928760356132, 14701.0, 14746.778798318033, 14890.0, 13859.23774192409, 14172.929135354463, 14454.85545144556, 14959.551213463614, 14966.551003469913, 8447.0, 8496.065432802387, 8578.699745509002, 8611.78470538229, 8627.266682331947, 6659.600423974577, 6682.398584127257, 6706.0, 6727.2263689674355, 6789.89815152783, 13108.2135071896, 13113.213207207598, 13217.669558261121, 13264.204147751167, 13299.135556188818, 13484.797728034284, 13560.525381611596, 13596.0, 13892.166470011427, 13894.374753135931, 8092.231238032377, 8154.551499667576, 8169.305609023062, 8306.501609903426, 8315.958420208102, 10435.739106522398, 10550.050495455445, 10558.736031599272, 10561.20790940698, 10569.312994655324, 8768.473891566526, 9058.456492610465, 9084.454932704059, 9100.135487128713, 9150.313726470407, 8786.297096232414, 8811.206991370807, 8897.377183597346, 8900.109989001307, 8955.41789783662, 8185.672573097009, 8232.876506852523, 8357.66569337244, 8358.958205208935, 8371.497710137168, 6004.832963802631, 6010.0, 6150.661713605795, 6230.158928544589, 6273.309935906956, 5952.821415357546, 6105.328413874381, 6216.502679785516, 6270.965290726979, 6344.837215332606], "value": 5304.861677635047, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [356.34076957628406, 383.21632262024156, 397.0867005886461, 407.6575676431795, 409.3041828890885, 5392.703401312926, 5653.236813030239, 5707.885842283163, 5713.771449142029, 5717.34250561185, 5746.712664366786, 5887.970560147193, 5905.608228667385, 5909.527237820975, 5987.0, 3352.580927384077, 4389.429374181352, 4552.863414097583, 4555.4533455985165, 4584.404027476424, 4088.2028004539125, 4266.445362102922, 4332.176886391591, 4334.826606935719, 4355.998120432302, 4100.405441211023, 4196.769177695225, 4270.0, 4282.464691913511, 4283.914321713564, 4186.413902053715, 4239.215745087154, 4282.164977829325, 4288.742675439484, 4299.247631664446, 3217.6460589335156, 3494.9825250873837, 3663.065918190871, 3683.834227459771, 3685.281370132825, 4690.50749671283, 5549.500544950974, 5623.465770751772, 5785.566082543826, 5800.303963524362, 4505.490660628693, 4777.59390451812, 4914.434839993411, 5063.1898896176435, 5078.974605126988, 4933.851984440473, 5189.455107213726, 6292.842678933018, 6337.524685648595, 6343.904841427382, 4053.3312003519386, 4138.475529926743, 4166.458360413158, 4180.28935081037, 4208.431861698662, 5725.942740572541, 6557.770478033293, 6588.93411065888, 6631.535792494527, 6636.336366363374, 4126.649234815014, 4190.916181676349, 4205.201011807747, 4210.0, 4215.768132752667, 3512.7892326460496, 3685.5577330720484, 3726.32926073304, 3846.903632464734, 4298.591633794785, 4822.614190864792, 5035.892103737172, 5040.445550989388, 5075.670081444694, 5085.237214417867, 4759.0, 5203.985222881502, 5360.91958620621, 5924.0, 6222.0, 1228.65597632663, 1434.8421673615894, 1457.5117335692662, 1458.5332693537966, 1459.8613131752466, 839.3495041342886, 911.6672414568635, 932.8787257656597, 949.5632009275672, 960.3181740963854, 5932.525397968152, 5996.331632423617, 6012.579119461596, 6029.246344206974, 6045.969770151209, 6294.0, 6425.453836423862, 6425.903611445832, 6576.046473261446, 6605.867882642417, 4937.950620493821, 5894.616849904743, 6024.819255422344, 6038.335783063947, 6184.350643182401, 2557.7108487903224, 2598.7271336509393, 3200.0879749271344, 3376.392249395083, 3389.322135572846, 6512.990486474604, 6723.899141512881, 6782.355676210752, 6787.389134977876, 6827.624480653512, 5994.6403215807195, 6289.930711778917, 6628.436582890508, 6649.501287403464, 6708.0, 5709.400512946164, 6506.31683673217, 6700.090474214923, 6704.296048914891, 6752.696128674123, 6151.292601350723, 6459.928955769886, 6466.960528551574, 6536.705848236936, 6550.853600619777, 5395.406505284337, 5928.79249226275, 6239.0, 6421.454176395058, 6497.31778163305, 6747.2915343890145, 6754.020667003158, 6757.290484499254, 6773.306673331667, 6793.214781939381, 3685.931079986774, 4196.307609244563, 4237.216115018731, 4248.617624413818, 4250.511191212926, 5788.334341550775, 6215.65813880241, 6498.707558159799, 6537.934620653733, 6601.840840270599, 5179.40436849752, 6360.586561873463, 6379.744810207725, 6402.455791257796, 6428.453581445629, 4983.72589507566, 5269.920951185812, 6305.5901366411035, 6370.649614271074, 6427.343937335302, 5366.490183432567, 6208.161898143873, 6245.375462453719, 6284.874302514016, 6297.370262973849, 5806.258122563129, 6292.717300783952, 6349.238091428873, 6386.521010924106, 6409.4231519163495, 5375.113106337567, 5987.874304621971, 6134.202553667995, 6166.81499555014, 6209.906851397323], "value": 4522.27733953082, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [705.8059033765717, 844.9577521123946, 849.0405841399217, 852.8635418333066, 861.7716305179129, 12881.677958051054, 17443.47669569912, 17614.943103413803, 18690.626187476275, 18727.812721872793, 14519.419223231058, 17316.913415432937, 17880.28478860844, 17898.0, 17919.73120403195, 971.2521358553892, 988.5946761827652, 989.6091044037637, 989.7030890732788, 1000.7848312612787, 660.6795704083515, 678.5826716569298, 1003.0270637481631, 1007.4559737741611, 1008.606643409071, 996.623054016173, 1003.0070230471816, 1005.8239808033602, 1006.0894890124449, 1035.7928414317166, 990.128686755654, 995.7610173558367, 999.0359303272377, 999.1157825324567, 1033.824249877519, 739.1499775258442, 739.2385842582149, 739.903812504371, 749.3967356278193, 769.9307062364414, 16310.592235194097, 16707.66584668312, 16840.663186736198, 16918.577035574086, 17212.22544985466, 16889.43985124022, 16948.576285592837, 17087.91456042724, 17349.95900245989, 17404.1297935104, 13762.105463144864, 13922.721545569133, 13965.441382344694, 14090.2954852258, 14105.36525856339, 3387.2040070583394, 3409.880654177092, 3412.4540073588355, 3414.641462646436, 3415.163284995167, 105644.0, 117945.0, 119345.0, 119827.0, 126528.36735816262, 10775.78448431027, 11889.940550297366, 12026.398680065962, 12034.699132521757, 12040.578579749666, 17491.387801427143, 19853.205871764967, 25112.623310650353, 25465.981360745733, 25473.490530189294, 7601.885971710429, 7878.527288362717, 7888.32949199313, 7889.763307100796, 7902.68389264423, 3888.3972984187494, 3968.3650615901893, 3973.6423721864594, 3974.423708562242, 3976.403539469045, 4220.936685949713, 4282.700210985201, 4344.391785150082, 4349.521552629209, 4356.760378179167, 825.4098319701442, 857.9828403432022, 860.5654144656908, 861.9353548483889, 864.9740507784777, 643.2474005413677, 678.281022116558, 681.1383599746325, 687.161662771418, 699.797058852927, 10623.628173013907, 11122.666320010412, 11564.42177891102, 12087.516499339928, 12181.878181218075, 648.7145655911384, 661.1438187547138, 663.7477758451757, 667.2360147630935, 684.1755684400285, 4913.459519452857, 4956.405231372259, 4977.90044199114, 4979.4771548987555, 5175.482451754794, 95338.5233073844, 95845.52077239708, 96662.51668741752, 96736.0, 98802.0, 84392.15607843966, 85147.7227841583, 85392.71910921342, 85994.57002714946, 86110.0, 73606.63196683982, 74009.0, 74017.62991185117, 74108.51782964419, 75940.0, 9349.736379613303, 9980.850287245843, 10156.035176658206, 10161.409389278113, 10199.184065274612, 40217.29415153018, 40401.39397908975, 40721.592784072964, 41425.0, 41492.585074150076, 52144.478555213966, 52278.95442091061, 52403.68990775261, 52699.47300526946, 52832.0, 14057.22685252321, 14168.858311417167, 14240.287985600886, 14459.13245205291, 14551.92724036373, 15058.096514209183, 15142.394304227708, 15376.461823836113, 15550.611234719223, 15627.45303914403, 14512.492062778174, 14647.0, 14877.702445951238, 14913.328900199735, 15013.849861501682, 13681.931590341985, 14210.644733881736, 14304.928475357556, 14313.713725725636, 14390.28048597545, 14488.710225795214, 14851.702965940836, 15299.694006119593, 16414.343426263295, 16463.753043704113, 10023.498825058572, 11669.59156429521, 11816.645500634995, 12027.338496382783, 12230.816537751763, 10550.419726914786, 11902.869227423382, 12994.285314307426, 13176.0, 13359.599212023655], "value": 7959.477361329137, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1476.3000000000002, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 110.0, 108.0, 108.0, 108.0, 110.0, 109.0, 110.0, 108.0, 110.0], "value": 109.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [133.0, 109.0, 107.0, 144.0, 102.0, 106.0, 106.0, 107.0, 133.0, 109.0], "value": 115.6, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 187.0, 183.0, 182.0, 187.0, 185.0, 185.0, 185.0, 186.0, 182.0], "value": 184.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 63.0, 75.0, 113.0, 52.0, 79.0, 82.0, 82.0, 80.0, 58.0], "value": 76.5, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [132.0, 69.0, 86.0, 94.0, 101.0, 103.0, 105.0, 67.0, 69.0, 111.0], "value": 93.7, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 86.0, 90.0, 89.0, 89.0, 88.0, 88.0, 89.0, 89.0, 90.0], "value": 88.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 96.0, 96.0, 96.0, 94.0, 95.0, 96.0, 95.0, 116.0, 146.0], "value": 102.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 98.0, 130.0, 88.0, 84.0, 84.0, 86.0, 84.0, 85.0, 86.0], "value": 91.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [48.0, 47.0, 47.0, 46.0, 48.0, 47.0, 50.0, 48.0, 47.0, 47.0], "value": 47.5, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [57.0, 65.0, 67.0, 53.0, 61.0, 60.0, 56.0, 56.0, 56.0, 56.0], "value": 58.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 81.0, 81.0, 86.0, 95.0, 95.0, 94.0, 104.0, 106.0], "value": 90.8, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [137.0, 137.0, 162.0, 135.0, 135.0, 136.0, 136.0, 142.0, 194.0, 135.0], "value": 144.9, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 188.0, 215.0, 182.0, 183.0, 189.0, 234.0, 203.0, 182.0, 185.0], "value": 194.7, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [69.0, 70.0, 73.0, 94.0, 94.0, 94.0, 75.0, 69.0, 69.0, 69.0], "value": 77.6, "unit": "score"}]}]} 09:53:11 INFO - Return code: 0 09:53:11 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 09:53:11 ERROR - # TBPL SUCCESS # 09:53:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 09:53:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 09:53:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 09:53:11 INFO - 2017-04-30 09:53:11.641 screenresolution[1672:16739] starting screenresolution argv=screenresolution get 09:53:11 INFO - 2017-04-30 09:53:11.643 screenresolution[1672:16739] Display 0: 1600x1200x32@60 09:53:11 INFO - 2017-04-30 09:53:11.649 screenresolution[1673:16742] starting screenresolution argv=screenresolution list 09:53:11 INFO - Available Modes on Display 0 09:53:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 09:53:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 09:53:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 09:53:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 09:53:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 09:53:11 INFO - Intel Iris: 09:53:11 INFO - Chipset Model: Intel Iris 09:53:11 INFO - Type: GPU 09:53:11 INFO - Bus: Built-In 09:53:11 INFO - VRAM (Dynamic, Max): 1536 MB 09:53:11 INFO - Vendor: Intel (0x8086) 09:53:11 INFO - Device ID: 0x0a2e 09:53:11 INFO - Revision ID: 0x0009 09:53:11 INFO - Displays: 09:53:11 INFO - Display: 09:53:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 09:53:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 09:53:11 INFO - Display Serial Number: 1600x1200 60 09:53:11 INFO - Main Display: Yes 09:53:11 INFO - Mirror: Off 09:53:11 INFO - Online: Yes 09:53:11 INFO - Rotation: Supported 09:53:11 INFO - Return code: 0 09:53:11 INFO - Running post-action listener: _resource_record_post_action 09:53:11 INFO - [mozharness: 2017-04-30 16:53:11.888321Z] Finished run-tests step (success) 09:53:11 INFO - Running post-run listener: _resource_record_post_run 09:53:11 INFO - Total resource usage - Wall time: 1201s; CPU: 53.0%; Read bytes: 34217472; Write bytes: 513359872; Read time: 314; Write time: 1723 09:53:11 INFO - TinderboxPrint: CPU usage
53.1% 09:53:11 INFO - TinderboxPrint: I/O read bytes / time
34,217,472 / 314 09:53:11 INFO - TinderboxPrint: I/O write bytes / time
513,359,872 / 1,723 09:53:11 INFO - TinderboxPrint: CPU idle
2,251.7 (46.9%) 09:53:11 INFO - TinderboxPrint: CPU system
953.2 (19.8%) 09:53:11 INFO - TinderboxPrint: CPU user
1,600.7 (33.3%) 09:53:11 INFO - TinderboxPrint: Swap in / out
238,415,872 / 0 09:53:11 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 209816064; Write bytes: 210112512; Read time: 16151; Write time: 388 09:53:11 INFO - run-tests - Wall time: 1182s; CPU: 53.0%; Read bytes: 29085184; Write bytes: 301912064; Read time: 280; Write time: 1329 09:53:12 INFO - Running post-run listener: _upload_blobber_files 09:53:12 INFO - Blob upload gear active. 09:53:12 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 09:53:12 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 09:53:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 09:53:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 09:53:12 INFO - (blobuploader) - INFO - Open directory for files ... 09:53:12 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 09:53:12 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:12 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:13 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 09:53:13 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:13 INFO - (blobuploader) - INFO - Done attempting. 09:53:13 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 09:53:13 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:13 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:14 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 09:53:14 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:14 INFO - (blobuploader) - INFO - Done attempting. 09:53:14 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 09:53:14 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:14 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:15 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 09:53:15 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:15 INFO - (blobuploader) - INFO - Done attempting. 09:53:15 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 09:53:15 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 09:53:15 INFO - (blobuploader) - INFO - Uploading, attempt #1. 09:53:18 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 09:53:18 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 09:53:18 INFO - (blobuploader) - INFO - Done attempting. 09:53:18 INFO - (blobuploader) - INFO - Iteration through files over. 09:53:18 INFO - Return code: 0 09:53:18 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 09:53:18 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 09:53:18 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad55714b87c8b51198f8341e88b9f4dbfe0705e7ad50c8a0b3a62393d2246552dc331fd602abd684087cbf7ae9148f6e87af7bc797f021b0a414c6b26c31458f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb6d78fbd10c46d0307a2cde81d0a17adb0da3b971d6b1e57935551edcffd31a831462d732faf8a66b82f0cc3f0c7edb8c7023f73311e21e5c1f3e09ada47bd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2522552cc30eb26c6f6c1c0a6fa68638d9c880ef4b1f8d7f48022aee8b5388326eefbad3680a94ef0b3af5917e0517646abbba7778e3ec639b268ec08e0403d3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c0179b96e5de911b1a4b1de517e40850cf97770945d1c8a6c4b95c59be0d91a27a167539938c237b310590279adef1493897bd6a9c0b529239e19faec72da54"} 09:53:18 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 09:53:18 INFO - Writing to file /builds/slave/test/properties/blobber_files 09:53:18 INFO - Contents: 09:53:18 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad55714b87c8b51198f8341e88b9f4dbfe0705e7ad50c8a0b3a62393d2246552dc331fd602abd684087cbf7ae9148f6e87af7bc797f021b0a414c6b26c31458f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb6d78fbd10c46d0307a2cde81d0a17adb0da3b971d6b1e57935551edcffd31a831462d732faf8a66b82f0cc3f0c7edb8c7023f73311e21e5c1f3e09ada47bd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2522552cc30eb26c6f6c1c0a6fa68638d9c880ef4b1f8d7f48022aee8b5388326eefbad3680a94ef0b3af5917e0517646abbba7778e3ec639b268ec08e0403d3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c0179b96e5de911b1a4b1de517e40850cf97770945d1c8a6c4b95c59be0d91a27a167539938c237b310590279adef1493897bd6a9c0b529239e19faec72da54"} 09:53:18 INFO - Running post-run listener: copy_logs_to_upload_dir 09:53:18 INFO - Copying logs to upload dir... 09:53:18 INFO - mkdir: /builds/slave/test/build/upload/logs 09:53:18 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1286.259518 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 26 secs) (at 2017-04-30 09:53:18.542645) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-30 09:53:18.548011) ========= 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.Waj73tYHrs/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.x42kCU61Yf/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad55714b87c8b51198f8341e88b9f4dbfe0705e7ad50c8a0b3a62393d2246552dc331fd602abd684087cbf7ae9148f6e87af7bc797f021b0a414c6b26c31458f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb6d78fbd10c46d0307a2cde81d0a17adb0da3b971d6b1e57935551edcffd31a831462d732faf8a66b82f0cc3f0c7edb8c7023f73311e21e5c1f3e09ada47bd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2522552cc30eb26c6f6c1c0a6fa68638d9c880ef4b1f8d7f48022aee8b5388326eefbad3680a94ef0b3af5917e0517646abbba7778e3ec639b268ec08e0403d3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c0179b96e5de911b1a4b1de517e40850cf97770945d1c8a6c4b95c59be0d91a27a167539938c237b310590279adef1493897bd6a9c0b529239e19faec72da54"} build_url:https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011159 build_url: 'https://queue.taskcluster.net/v1/task/PTmDRtF_Qt2LW3hRq1N5pA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/ad55714b87c8b51198f8341e88b9f4dbfe0705e7ad50c8a0b3a62393d2246552dc331fd602abd684087cbf7ae9148f6e87af7bc797f021b0a414c6b26c31458f", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/cb6d78fbd10c46d0307a2cde81d0a17adb0da3b971d6b1e57935551edcffd31a831462d732faf8a66b82f0cc3f0c7edb8c7023f73311e21e5c1f3e09ada47bd8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/2522552cc30eb26c6f6c1c0a6fa68638d9c880ef4b1f8d7f48022aee8b5388326eefbad3680a94ef0b3af5917e0517646abbba7778e3ec639b268ec08e0403d3", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6c0179b96e5de911b1a4b1de517e40850cf97770945d1c8a6c4b95c59be0d91a27a167539938c237b310590279adef1493897bd6a9c0b529239e19faec72da54"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-30 09:53:18.583555) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 09:53:18.583903) ========= 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.Waj73tYHrs/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.x42kCU61Yf/Listeners TMPDIR=/var/folders/dm/htz3_8912qn7fxnzm0b7jt8800000w/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.005223 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-30 09:53:18.632738) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-30 09:53:18.633076) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-30 09:53:18.633430) ========= ========= Total master_lag: 0.21 =========