builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0392 starttime: 1491651179.34 results: success (0) buildid: 20170408030204 builduid: 45b76d9c61284338b30d3d52a162e7ff revision: 35c7be9c2db288d1d449e3cc586c4164d642c5fd ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-08 04:32:59.337534) ========= master: http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-08 04:32:59.338039) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-08 04:32:59.338375) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-08 04:32:59.432792) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 04:32:59.433255) ========= 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.mJt7CF34Vv/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.gABp1l7gK4/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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-08 04:32:59-- 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% 171M=0s 2017-04-08 04:32:59 (171 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.116376 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 04:32:59.576654) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 04:32:59.576987) ========= 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.mJt7CF34Vv/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.gABp1l7gK4/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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.025871 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 04:32:59.626134) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-08 04:32:59.626528) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 35c7be9c2db288d1d449e3cc586c4164d642c5fd --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 35c7be9c2db288d1d449e3cc586c4164d642c5fd --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.mJt7CF34Vv/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.gABp1l7gK4/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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-08 04:32:59,740 truncating revision to first 12 chars 2017-04-08 04:32:59,740 Setting DEBUG logging. 2017-04-08 04:32:59,740 attempt 1/10 2017-04-08 04:32:59,740 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/35c7be9c2db2?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-08 04:33:00,837 unpacking tar archive at: mozilla-central-35c7be9c2db2/testing/mozharness/ program finished with exit code 0 elapsedTime=1.387023 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-08 04:33:01.038973) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-08 04:33:01.039798) ========= script_repo_revision: 35c7be9c2db288d1d449e3cc586c4164d642c5fd ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-08 04:33:01.040468) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-08 04:33:01.041511) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-08 04:33:01.067660) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2017-04-08 04:33:01.068265) ========= /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.mJt7CF34Vv/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.gABp1l7gK4/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:33:01 INFO - MultiFileLogger online at 20170408 04:33:01 in /builds/slave/test 04:33:01 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:33:01 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:33:01 INFO - {'append_to_log': False, 04:33:01 INFO - 'base_work_dir': '/builds/slave/test', 04:33:01 INFO - 'blob_upload_branch': 'Firefox', 04:33:01 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:33:01 INFO - 'branch': 'Firefox', 04:33:01 INFO - 'buildbot_json_path': 'buildprops.json', 04:33:01 INFO - 'config_files': ('talos/mac_config.py',), 04:33:01 INFO - 'default_actions': ('clobber', 04:33:01 INFO - 'read-buildbot-config', 04:33:01 INFO - 'download-and-extract', 04:33:01 INFO - 'populate-webroot', 04:33:01 INFO - 'create-virtualenv', 04:33:01 INFO - 'install', 04:33:01 INFO - 'run-tests'), 04:33:01 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:33:01 INFO - 'download_minidump_stackwalk': True, 04:33:01 INFO - 'download_symbols': 'ondemand', 04:33:01 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:33:01 INFO - 'tooltool.py': '/tools/tooltool.py', 04:33:01 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:33:01 INFO - '/tools/misc-python/virtualenv.py')}, 04:33:01 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:33:01 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:33:01 INFO - 'gecko_profile': False, 04:33:01 INFO - 'gecko_profile_interval': 0, 04:33:01 INFO - 'installer_path': 'installer.exe', 04:33:01 INFO - 'log_level': 'info', 04:33:01 INFO - 'log_name': 'talos', 04:33:01 INFO - 'log_to_console': True, 04:33:01 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:33:01 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:33:01 INFO - 'opt_config_files': (), 04:33:01 INFO - 'pip_index': False, 04:33:01 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:33:01 INFO - 'cmd': ('bash', 04:33:01 INFO - '-c', 04:33:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:33:01 INFO - 'enabled': True, 04:33:01 INFO - 'halt_on_failure': False, 04:33:01 INFO - 'name': 'check_screen_resolution'},), 04:33:01 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:33:01 INFO - 'cmd': ('bash', 04:33:01 INFO - '-c', 04:33:01 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:33:01 INFO - 'enabled': True, 04:33:01 INFO - 'halt_on_failure': False, 04:33:01 INFO - 'name': 'check_screen_resolution'},), 04:33:01 INFO - 'run_cmd_checks_enabled': True, 04:33:01 INFO - 'suite': 'dromaeojs', 04:33:01 INFO - 'system_bits': '32', 04:33:01 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:33:01 INFO - 'title': 't-yosemite-r7-0392', 04:33:01 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:33:01 INFO - 'use_talos_json': True, 04:33:01 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:33:01 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:33:01 INFO - 'work_dir': 'build'} 04:33:01 INFO - [mozharness: 2017-04-08 11:33:01.287053Z] Running clobber step. 04:33:01 INFO - Running pre-action listener: _resource_record_pre_action 04:33:01 INFO - Running main action method: clobber 04:33:01 INFO - rmtree: /builds/slave/test/build 04:33:01 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:33:03 INFO - Running post-action listener: _resource_record_post_action 04:33:03 INFO - [mozharness: 2017-04-08 11:33:03.750501Z] Finished clobber step (success) 04:33:03 INFO - [mozharness: 2017-04-08 11:33:03.750703Z] Running read-buildbot-config step. 04:33:03 INFO - Running pre-action listener: _resource_record_pre_action 04:33:03 INFO - Running main action method: read_buildbot_config 04:33:03 INFO - Using buildbot properties: 04:33:03 INFO - { 04:33:03 INFO - "project": "", 04:33:03 INFO - "product": "firefox", 04:33:03 INFO - "script_repo_revision": "production", 04:33:03 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:33:03 INFO - "repository": "", 04:33:03 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:33:03 INFO - "buildid": "20170408030204", 04:33:03 INFO - "stage_platform": "macosx64", 04:33:03 INFO - "basedir": "/builds/slave/test", 04:33:03 INFO - "nightly_build": "True", 04:33:03 INFO - "buildnumber": 71, 04:33:03 INFO - "slavename": "t-yosemite-r7-0392", 04:33:03 INFO - "master": "http://buildbot-master135.bb.releng.scl3.mozilla.com:8201/", 04:33:03 INFO - "platform": "yosemite_r7", 04:33:03 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:33:03 INFO - "branch": "mozilla-central", 04:33:03 INFO - "repo_path": "mozilla-central", 04:33:03 INFO - "revision": "35c7be9c2db288d1d449e3cc586c4164d642c5fd", 04:33:03 INFO - "pgo_build": "False", 04:33:03 INFO - "builduid": "45b76d9c61284338b30d3d52a162e7ff", 04:33:03 INFO - "slavebuilddir": "test" 04:33:03 INFO - } 04:33:03 INFO - Found installer url https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:33:03 INFO - Running post-action listener: _resource_record_post_action 04:33:03 INFO - [mozharness: 2017-04-08 11:33:03.754934Z] Finished read-buildbot-config step (success) 04:33:03 INFO - [mozharness: 2017-04-08 11:33:03.755063Z] Running download-and-extract step. 04:33:03 INFO - Running pre-action listener: _resource_record_pre_action 04:33:03 INFO - Running main action method: download_and_extract 04:33:03 INFO - mkdir: /builds/slave/test/build/tests 04:33:03 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:03 INFO - trying https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:33:03 INFO - Downloading https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:33:03 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:33:05 INFO - Downloaded 1325 bytes. 04:33:05 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:33:05 INFO - Using the following test package requirements: 04:33:05 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:33:05 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:33:05 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:33:05 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:33:05 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'jsshell-mac.zip'], 04:33:05 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:33:05 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:33:05 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:33:05 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:33:05 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:33:05 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:33:05 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:33:05 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:33:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:33:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:33:05 INFO - Fetch https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:33:07 INFO - Expected file size: 52521421 04:33:07 INFO - Obtained file size: 52521421 04:33:24 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:33:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:33:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:33:24 INFO - Fetch https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:33:26 INFO - Expected file size: 52521421 04:33:26 INFO - Obtained file size: 52521421 04:33:41 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:33:41 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:33:41 INFO - Fetch https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:33:42 INFO - Expected file size: 14404138 04:33:42 INFO - Obtained file size: 14404138 04:33:42 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:42 INFO - trying https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:33:42 INFO - Downloading https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:33:42 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:33:44 INFO - Downloaded 71001370 bytes. 04:33:44 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:33:44 INFO - mkdir: /builds/slave/test/properties 04:33:44 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:33:44 INFO - Writing to file /builds/slave/test/properties/build_url 04:33:44 INFO - Contents: 04:33:44 INFO - build_url:https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:33:45 INFO - Running post-action listener: _resource_record_post_action 04:33:45 INFO - Running post-action listener: set_extra_try_arguments 04:33:45 INFO - [mozharness: 2017-04-08 11:33:45.262760Z] Finished download-and-extract step (success) 04:33:45 INFO - [mozharness: 2017-04-08 11:33:45.262900Z] Running populate-webroot step. 04:33:45 INFO - Running pre-action listener: _resource_record_pre_action 04:33:45 INFO - Running main action method: populate_webroot 04:33:45 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:33:45 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:33:45 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:33:45 INFO - '--tppagecycles', 04:33:45 INFO - '7'], 04:33:45 INFO - 'tests': ['tsvgm']}}, 04:33:45 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:33:45 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:33:45 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:33:45 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:33:45 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:33:45 INFO - 'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:45 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:33:45 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:33:45 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:33:45 INFO - 'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['damp', 'tps']}, 04:33:45 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:33:45 INFO - 'tests': ['damp', 'tps']}, 04:33:45 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['dromaeo_dom']}, 04:33:45 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:33:45 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['basic_compositor_video']}, 04:33:45 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:33:45 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['a11yr', 04:33:45 INFO - 'ts_paint', 04:33:45 INFO - 'tpaint', 04:33:45 INFO - 'sessionrestore', 04:33:45 INFO - 'sessionrestore_no_auto_restore', 04:33:45 INFO - 'tabpaint']}, 04:33:45 INFO - 'other-e10s': {'tests': ['a11yr', 04:33:45 INFO - 'ts_paint', 04:33:45 INFO - 'tpaint', 04:33:45 INFO - 'sessionrestore', 04:33:45 INFO - 'sessionrestore_no_auto_restore', 04:33:45 INFO - 'tabpaint']}, 04:33:45 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:33:45 INFO - 'ts_paint', 04:33:45 INFO - 'tpaint', 04:33:45 INFO - 'sessionrestore', 04:33:45 INFO - 'sessionrestore_no_auto_restore', 04:33:45 INFO - 'tabpaint']}, 04:33:45 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:33:45 INFO - 'ts_paint', 04:33:45 INFO - 'tpaint', 04:33:45 INFO - 'sessionrestore', 04:33:45 INFO - 'sessionrestore_no_auto_restore', 04:33:45 INFO - 'tabpaint']}, 04:33:45 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['a11yr', 04:33:45 INFO - 'ts_paint', 04:33:45 INFO - 'tpaint', 04:33:45 INFO - 'sessionrestore', 04:33:45 INFO - 'sessionrestore_no_auto_restore', 04:33:45 INFO - 'tabpaint']}, 04:33:45 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['a11yr', 04:33:45 INFO - 'ts_paint', 04:33:45 INFO - 'tpaint', 04:33:45 INFO - 'sessionrestore', 04:33:45 INFO - 'sessionrestore_no_auto_restore', 04:33:45 INFO - 'tabpaint']}, 04:33:45 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['tsvgx', 04:33:45 INFO - 'tsvgr_opacity', 04:33:45 INFO - 'tart', 04:33:45 INFO - 'tscrollx', 04:33:45 INFO - 'cart', 04:33:45 INFO - 'tsvg_static']}, 04:33:45 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:33:45 INFO - 'tsvgr_opacity', 04:33:45 INFO - 'tart', 04:33:45 INFO - 'tscrollx', 04:33:45 INFO - 'cart', 04:33:45 INFO - 'tsvg_static']}, 04:33:45 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:33:45 INFO - 'talos_options': ['--disable-e10s'], 04:33:45 INFO - 'tests': ['tp5o']}, 04:33:45 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:33:45 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:33:45 INFO - 'talos_options': ['--disable-e10s', 04:33:45 INFO - '--xperf_path', 04:33:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:45 INFO - 'tests': ['tp5n']}, 04:33:45 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:33:45 INFO - 'talos_options': ['--xperf_path', 04:33:45 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:33:45 INFO - 'tests': ['tp5n']}}, 04:33:45 INFO - 'talos.zip': {'path': '', 04:33:45 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:33:45 INFO - Running post-action listener: _resource_record_post_action 04:33:45 INFO - [mozharness: 2017-04-08 11:33:45.281264Z] Finished populate-webroot step (success) 04:33:45 INFO - [mozharness: 2017-04-08 11:33:45.281375Z] Running create-virtualenv step. 04:33:45 INFO - Running pre-action listener: _resource_record_pre_action 04:33:45 INFO - Running main action method: create_virtualenv 04:33:45 INFO - Creating virtualenv /builds/slave/test/build/venv 04:33:45 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:33:45 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:33:45 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:33:45 INFO - Using real prefix '/tools/python27' 04:33:45 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:33:46 INFO - Installing distribute.............................................................................................................................................................................................done. 04:33:48 INFO - Installing pip.................done. 04:33:49 INFO - Return code: 0 04:33:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:33:49 INFO - Reading from file tmpfile_stdout 04:33:49 INFO - Output received: 04:33:49 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:33:49 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:49 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 0x10671eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86cacab870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064fcd30>, '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 0x106423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f1be8>, '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.mJt7CF34Vv/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.gABp1l7gK4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:33:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mJt7CF34Vv/Render', 04:33:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:49 INFO - 'HOME': '/Users/cltbld', 04:33:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:49 INFO - 'LOGNAME': 'cltbld', 04:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:49 INFO - 'MOZ_NO_REMOTE': '1', 04:33:49 INFO - 'NO_EM_RESTART': '1', 04:33:49 INFO - 'PAGER': '/bin/cat', 04:33:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:49 INFO - 'PWD': '/builds/slave/test', 04:33:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:49 INFO - 'SHELL': '/bin/bash', 04:33:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gABp1l7gK4/Listeners', 04:33:49 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 04:33:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:49 INFO - 'USER': 'cltbld', 04:33:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:49 INFO - 'XPC_FLAGS': '0x0', 04:33:49 INFO - 'XPC_SERVICE_NAME': '0', 04:33:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:49 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:33:49 INFO - Cleaning up... 04:33:49 INFO - Return code: 0 04:33:49 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:49 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 0x10671eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86cacab870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064fcd30>, '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 0x106423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f1be8>, '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.mJt7CF34Vv/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.gABp1l7gK4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:33:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:33:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mJt7CF34Vv/Render', 04:33:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:49 INFO - 'HOME': '/Users/cltbld', 04:33:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:49 INFO - 'LOGNAME': 'cltbld', 04:33:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:49 INFO - 'MOZ_NO_REMOTE': '1', 04:33:49 INFO - 'NO_EM_RESTART': '1', 04:33:49 INFO - 'PAGER': '/bin/cat', 04:33:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:49 INFO - 'PWD': '/builds/slave/test', 04:33:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:49 INFO - 'SHELL': '/bin/bash', 04:33:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gABp1l7gK4/Listeners', 04:33:49 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 04:33:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:49 INFO - 'USER': 'cltbld', 04:33:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:49 INFO - 'XPC_FLAGS': '0x0', 04:33:49 INFO - 'XPC_SERVICE_NAME': '0', 04:33:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:50 INFO - Downloading/unpacking psutil>=3.1.1 04:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:50 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:50 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:33:50 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:33:50 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:33:56 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:33:56 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:33:56 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:33:56 INFO - Installing collected packages: psutil 04:33:56 INFO - Running setup.py install for psutil 04:33:56 INFO - building 'psutil._psutil_osx' extension 04:33:56 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:33:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:33:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:33:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:33:57 INFO - building 'psutil._psutil_posix' extension 04:33:57 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:33:57 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:33:57 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:33:57 INFO - ^ 04:33:57 INFO - 1 warning generated. 04:33:57 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:33:57 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:33:57 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:33:57 INFO - Successfully installed psutil 04:33:57 INFO - Cleaning up... 04:33:58 INFO - Return code: 0 04:33:58 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:33:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:33:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:33:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:33:58 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 0x10671eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86cacab870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064fcd30>, '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 0x106423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f1be8>, '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.mJt7CF34Vv/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.gABp1l7gK4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:33:58 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:33:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:33:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mJt7CF34Vv/Render', 04:33:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:33:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:33:58 INFO - 'HOME': '/Users/cltbld', 04:33:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:33:58 INFO - 'LOGNAME': 'cltbld', 04:33:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:33:58 INFO - 'MOZ_NO_REMOTE': '1', 04:33:58 INFO - 'NO_EM_RESTART': '1', 04:33:58 INFO - 'PAGER': '/bin/cat', 04:33:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:33:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:33:58 INFO - 'PWD': '/builds/slave/test', 04:33:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:33:58 INFO - 'SHELL': '/bin/bash', 04:33:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gABp1l7gK4/Listeners', 04:33:58 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 04:33:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:33:58 INFO - 'USER': 'cltbld', 04:33:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:33:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:33:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:33:58 INFO - 'XPC_FLAGS': '0x0', 04:33:58 INFO - 'XPC_SERVICE_NAME': '0', 04:33:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:33:58 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:33:58 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:33: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 04:33: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 04:33: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 04:33: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 04:33: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 04:33: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 04:34:08 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:34:08 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:34:08 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:34:08 INFO - Installing collected packages: mozsystemmonitor 04:34:08 INFO - Running setup.py install for mozsystemmonitor 04:34:08 INFO - Successfully installed mozsystemmonitor 04:34:08 INFO - Cleaning up... 04:34:08 INFO - Return code: 0 04:34:08 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:08 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:08 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:08 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:08 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:08 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 0x10671eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86cacab870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064fcd30>, '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 0x106423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f1be8>, '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.mJt7CF34Vv/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.gABp1l7gK4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:08 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:34:08 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:34:08 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mJt7CF34Vv/Render', 04:34:08 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:08 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:08 INFO - 'HOME': '/Users/cltbld', 04:34:08 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:08 INFO - 'LOGNAME': 'cltbld', 04:34:08 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:08 INFO - 'MOZ_NO_REMOTE': '1', 04:34:08 INFO - 'NO_EM_RESTART': '1', 04:34:08 INFO - 'PAGER': '/bin/cat', 04:34:08 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:08 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:08 INFO - 'PWD': '/builds/slave/test', 04:34:08 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:08 INFO - 'SHELL': '/bin/bash', 04:34:08 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gABp1l7gK4/Listeners', 04:34:08 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 04:34:08 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:08 INFO - 'USER': 'cltbld', 04:34:08 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:08 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:08 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:08 INFO - 'XPC_FLAGS': '0x0', 04:34:08 INFO - 'XPC_SERVICE_NAME': '0', 04:34:08 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:08 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:08 INFO - Downloading/unpacking jsonschema==2.5.1 04:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:08 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:08 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:08 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:08 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:12 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:34:12 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:12 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:12 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:12 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:12 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:12 INFO - Downloading functools32-3.2.3-2.tar.gz 04:34:12 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:34:12 INFO - warning: no files found matching '*.txt' 04:34:12 INFO - no previously-included directories found matching 'build' 04:34:12 INFO - no previously-included directories found matching 'dist' 04:34:12 INFO - no previously-included directories found matching '.git*' 04:34:12 INFO - Installing collected packages: jsonschema, functools32 04:34:12 INFO - Running setup.py install for functools32 04:34:13 INFO - warning: no files found matching '*.txt' 04:34:13 INFO - no previously-included directories found matching 'build' 04:34:13 INFO - no previously-included directories found matching 'dist' 04:34:13 INFO - no previously-included directories found matching '.git*' 04:34:13 INFO - Successfully installed jsonschema functools32 04:34:13 INFO - Cleaning up... 04:34:13 INFO - Return code: 0 04:34:13 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:13 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 0x10671eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86cacab870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064fcd30>, '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 0x106423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f1be8>, '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.mJt7CF34Vv/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.gABp1l7gK4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:34:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mJt7CF34Vv/Render', 04:34:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:13 INFO - 'HOME': '/Users/cltbld', 04:34:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:13 INFO - 'LOGNAME': 'cltbld', 04:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:13 INFO - 'MOZ_NO_REMOTE': '1', 04:34:13 INFO - 'NO_EM_RESTART': '1', 04:34:13 INFO - 'PAGER': '/bin/cat', 04:34:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:13 INFO - 'PWD': '/builds/slave/test', 04:34:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:13 INFO - 'SHELL': '/bin/bash', 04:34:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gABp1l7gK4/Listeners', 04:34:13 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 04:34:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:13 INFO - 'USER': 'cltbld', 04:34:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:13 INFO - 'XPC_FLAGS': '0x0', 04:34:13 INFO - 'XPC_SERVICE_NAME': '0', 04:34:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:13 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:34:13 INFO - Cleaning up... 04:34:13 INFO - Return code: 0 04:34:13 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:13 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:13 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:13 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:13 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:13 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 0x10671eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86cacab870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064fcd30>, '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 0x106423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f1be8>, '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.mJt7CF34Vv/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.gABp1l7gK4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:13 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:34:13 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:34:13 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mJt7CF34Vv/Render', 04:34:13 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:13 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:13 INFO - 'HOME': '/Users/cltbld', 04:34:13 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:13 INFO - 'LOGNAME': 'cltbld', 04:34:13 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:13 INFO - 'MOZ_NO_REMOTE': '1', 04:34:13 INFO - 'NO_EM_RESTART': '1', 04:34:13 INFO - 'PAGER': '/bin/cat', 04:34:13 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:13 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:13 INFO - 'PWD': '/builds/slave/test', 04:34:13 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:13 INFO - 'SHELL': '/bin/bash', 04:34:13 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gABp1l7gK4/Listeners', 04:34:13 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 04:34:13 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:13 INFO - 'USER': 'cltbld', 04:34:13 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:13 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:13 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:13 INFO - 'XPC_FLAGS': '0x0', 04:34:13 INFO - 'XPC_SERVICE_NAME': '0', 04:34:13 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:13 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:13 INFO - Downloading/unpacking blobuploader==1.2.4 04:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:13 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:13 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:13 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:13 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:16 INFO - Downloading blobuploader-1.2.4.tar.gz 04:34:16 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:34:16 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:16 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:16 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:16 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:16 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:34:17 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:17 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:17 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:17 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:17 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:17 INFO - Downloading docopt-0.6.1.tar.gz 04:34:17 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:34:17 INFO - Installing collected packages: blobuploader, requests, docopt 04:34:17 INFO - Running setup.py install for blobuploader 04:34:17 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:34:17 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:34:17 INFO - Running setup.py install for requests 04:34:18 INFO - Running setup.py install for docopt 04:34:18 INFO - Successfully installed blobuploader requests docopt 04:34:18 INFO - Cleaning up... 04:34:18 INFO - Return code: 0 04:34:18 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:18 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:18 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:18 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:18 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:18 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:18 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 0x10671eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86cacab870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064fcd30>, '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 0x106423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f1be8>, '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.mJt7CF34Vv/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.gABp1l7gK4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:18 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:34:18 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:34:18 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mJt7CF34Vv/Render', 04:34:18 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:18 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:18 INFO - 'HOME': '/Users/cltbld', 04:34:18 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:18 INFO - 'LOGNAME': 'cltbld', 04:34:18 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:18 INFO - 'MOZ_NO_REMOTE': '1', 04:34:18 INFO - 'NO_EM_RESTART': '1', 04:34:18 INFO - 'PAGER': '/bin/cat', 04:34:18 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:18 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:18 INFO - 'PWD': '/builds/slave/test', 04:34:18 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:18 INFO - 'SHELL': '/bin/bash', 04:34:18 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gABp1l7gK4/Listeners', 04:34:18 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 04:34:18 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:18 INFO - 'USER': 'cltbld', 04:34:18 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:18 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:18 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:18 INFO - 'XPC_FLAGS': '0x0', 04:34:18 INFO - 'XPC_SERVICE_NAME': '0', 04:34:18 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:18 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:18 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:18 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-fjISEv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:19 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-khdgGg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:19 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-vi0ZhY-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:19 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-7URCGB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:19 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-MA7UuH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:19 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-YT6dNO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:19 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-JNpc4u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:19 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-fGtY57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:19 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-GLxNc6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:19 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:19 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-xEC73t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:20 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-ClkhnH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:20 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-u6dAIU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:20 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-bBStTp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:20 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-4PvHHk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:20 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-k0czLg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:20 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-Kkeiwp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:20 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:20 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-fSebeB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:20 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:34:20 INFO - Running setup.py install for manifestparser 04:34:20 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:34:20 INFO - Running setup.py install for mozcrash 04:34:21 INFO - Running setup.py install for mozdebug 04:34:21 INFO - Running setup.py install for mozdevice 04:34:21 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:34:21 INFO - Running setup.py install for mozfile 04:34:21 INFO - Running setup.py install for mozhttpd 04:34:21 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:34:21 INFO - Running setup.py install for mozinfo 04:34:21 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:34:21 INFO - Running setup.py install for mozInstall 04:34:21 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:34:21 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:34:21 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:34:21 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:34:21 INFO - Running setup.py install for mozleak 04:34:21 INFO - Running setup.py install for mozlog 04:34:22 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:34:22 INFO - Running setup.py install for moznetwork 04:34:22 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:34:22 INFO - Running setup.py install for mozprocess 04:34:22 INFO - Running setup.py install for mozprofile 04:34:22 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:34:22 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:34:22 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:34:22 INFO - Running setup.py install for mozrunner 04:34:22 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:34:22 INFO - Running setup.py install for mozscreenshot 04:34:22 INFO - Running setup.py install for moztest 04:34:23 INFO - Running setup.py install for mozversion 04:34:23 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:34:23 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:34:23 INFO - Cleaning up... 04:34:23 INFO - Return code: 0 04:34:23 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:23 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:23 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:23 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:23 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:23 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:23 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 0x10671eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86cacab870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064fcd30>, '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 0x106423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f1be8>, '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.mJt7CF34Vv/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.gABp1l7gK4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:23 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:34:23 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:34:23 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mJt7CF34Vv/Render', 04:34:23 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:23 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:23 INFO - 'HOME': '/Users/cltbld', 04:34:23 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:23 INFO - 'LOGNAME': 'cltbld', 04:34:23 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:23 INFO - 'MOZ_NO_REMOTE': '1', 04:34:23 INFO - 'NO_EM_RESTART': '1', 04:34:23 INFO - 'PAGER': '/bin/cat', 04:34:23 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:23 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:23 INFO - 'PWD': '/builds/slave/test', 04:34:23 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:23 INFO - 'SHELL': '/bin/bash', 04:34:23 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gABp1l7gK4/Listeners', 04:34:23 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 04:34:23 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:23 INFO - 'USER': 'cltbld', 04:34:23 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:23 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:23 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:23 INFO - 'XPC_FLAGS': '0x0', 04:34:23 INFO - 'XPC_SERVICE_NAME': '0', 04:34:23 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:23 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:34:23 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-HNwr14-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:34:23 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:34:23 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-poluHU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:34:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:34:23 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-4GrzYB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:34:23 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:34:23 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-GwksfF-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:34:23 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)) 04:34:23 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:34:23 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-bBM28X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:34:24 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-OCxTxk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:34:24 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-6fahik-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:34:24 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-lL7a__-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:34:24 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-XW1pd8-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:34:24 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-8y1gnU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:34:24 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-6jQTIM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:34:24 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-TF1tES-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:34:24 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-JqtJT9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:34:24 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:34:24 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:34:24 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-EkY_Dr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:25 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-rJ8buT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:34:25 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-jRtq21-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:34:25 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:34:25 INFO - Running setup.py (path:/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/pip-vB6ghJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:34:25 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:34:25 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)) 04:34:25 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)) 04:34:25 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:25 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:25 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:34:25 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:34:25 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:34:28 INFO - Downloading blessings-1.6.tar.gz 04:34:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:34:28 INFO - Installing collected packages: blessings 04:34:28 INFO - Running setup.py install for blessings 04:34:28 INFO - Successfully installed blessings 04:34:28 INFO - Cleaning up... 04:34:28 INFO - Return code: 0 04:34:28 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:34:28 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:28 INFO - Reading from file tmpfile_stdout 04:34:28 INFO - Current package versions: 04:34:28 INFO - blessings == 1.6 04:34:28 INFO - blobuploader == 1.2.4 04:34:28 INFO - docopt == 0.6.1 04:34:28 INFO - functools32 == 3.2.3-2 04:34:28 INFO - jsonschema == 2.5.1 04:34:28 INFO - manifestparser == 1.1 04:34:28 INFO - mozInstall == 1.12 04:34:28 INFO - mozcrash == 1.0 04:34:28 INFO - mozdebug == 0.1 04:34:28 INFO - mozdevice == 0.50 04:34:28 INFO - mozfile == 1.2 04:34:28 INFO - mozhttpd == 0.7 04:34:28 INFO - mozinfo == 0.9 04:34:28 INFO - mozleak == 0.1 04:34:28 INFO - mozlog == 3.4 04:34:28 INFO - moznetwork == 0.27 04:34:28 INFO - mozprocess == 0.25 04:34:28 INFO - mozprofile == 0.28 04:34:28 INFO - mozrunner == 6.13 04:34:28 INFO - mozscreenshot == 0.1 04:34:28 INFO - mozsystemmonitor == 0.3 04:34:28 INFO - moztest == 0.8 04:34:28 INFO - mozversion == 1.4 04:34:28 INFO - psutil == 3.1.1 04:34:28 INFO - requests == 1.2.3 04:34:28 INFO - wsgiref == 0.1.2 04:34:28 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:28 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:28 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:28 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:28 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:28 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:28 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 0x10671eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86cacab870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064fcd30>, '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 0x106423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f1be8>, '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.mJt7CF34Vv/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.gABp1l7gK4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:28 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:34:28 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:34:28 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mJt7CF34Vv/Render', 04:34:28 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:28 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:28 INFO - 'HOME': '/Users/cltbld', 04:34:28 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:28 INFO - 'LOGNAME': 'cltbld', 04:34:28 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:28 INFO - 'MOZ_NO_REMOTE': '1', 04:34:28 INFO - 'NO_EM_RESTART': '1', 04:34:28 INFO - 'PAGER': '/bin/cat', 04:34:28 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:28 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:28 INFO - 'PWD': '/builds/slave/test', 04:34:28 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:28 INFO - 'SHELL': '/bin/bash', 04:34:28 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gABp1l7gK4/Listeners', 04:34:28 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 04:34:28 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:28 INFO - 'USER': 'cltbld', 04:34:28 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:28 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:28 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:28 INFO - 'XPC_FLAGS': '0x0', 04:34:28 INFO - 'XPC_SERVICE_NAME': '0', 04:34:28 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:34:29 INFO - Cleaning up... 04:34:29 INFO - Return code: 0 04:34:29 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:34:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:34:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:34:29 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 0x10671eb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106721768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7f86cacab870>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1064fcd30>, '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 0x106423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f1be8>, '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.mJt7CF34Vv/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.gABp1l7gK4/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:34:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:34:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mJt7CF34Vv/Render', 04:34:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:29 INFO - 'HOME': '/Users/cltbld', 04:34:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:29 INFO - 'LOGNAME': 'cltbld', 04:34:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:29 INFO - 'MOZ_NO_REMOTE': '1', 04:34:29 INFO - 'NO_EM_RESTART': '1', 04:34:29 INFO - 'PAGER': '/bin/cat', 04:34:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:29 INFO - 'PWD': '/builds/slave/test', 04:34:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:29 INFO - 'SHELL': '/bin/bash', 04:34:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gABp1l7gK4/Listeners', 04:34:29 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 04:34:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:29 INFO - 'USER': 'cltbld', 04:34:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:29 INFO - 'XPC_FLAGS': '0x0', 04:34:29 INFO - 'XPC_SERVICE_NAME': '0', 04:34:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:29 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:34:29 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:34:29 INFO - Cleaning up... 04:34:29 INFO - Return code: 0 04:34:29 INFO - Running post-action listener: _resource_record_post_action 04:34:29 INFO - Running post-action listener: _start_resource_monitoring 04:34:29 INFO - Starting resource monitoring. 04:34:29 INFO - [mozharness: 2017-04-08 11:34:29.469845Z] Finished create-virtualenv step (success) 04:34:29 INFO - [mozharness: 2017-04-08 11:34:29.470825Z] Running install step. 04:34:29 INFO - Running pre-action listener: _resource_record_pre_action 04:34:29 INFO - Running main action method: install 04:34:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:34:29 INFO - Reading from file tmpfile_stdout 04:34:29 INFO - Detecting whether we're running mozinstall >=1.0... 04:34:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:34:29 INFO - Reading from file tmpfile_stdout 04:34:29 INFO - Output received: 04:34:29 INFO - Usage: mozinstall [options] installer 04:34:29 INFO - Options: 04:34:29 INFO - -h, --help show this help message and exit 04:34:29 INFO - -d DEST, --destination=DEST 04:34:29 INFO - Directory to install application into. [default: 04:34:29 INFO - "/builds/slave/test"] 04:34:29 INFO - --app=APP Application being installed. [default: firefox] 04:34:29 INFO - mkdir: /builds/slave/test/build/application 04:34:29 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:34:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:34:49 INFO - Reading from file tmpfile_stdout 04:34:49 INFO - Output received: 04:34:49 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:34:49 INFO - Running post-action listener: _resource_record_post_action 04:34:49 INFO - [mozharness: 2017-04-08 11:34:49.707451Z] Finished install step (success) 04:34:49 INFO - [mozharness: 2017-04-08 11:34:49.707588Z] Running run-tests step. 04:34:49 INFO - Running pre-action listener: _resource_record_pre_action 04:34:49 INFO - Running main action method: run_tests 04:34:49 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:34:49 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:34:49 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:34:49 INFO - 2017-04-08 04:34:49.721 screenresolution[1670:12185] starting screenresolution argv=screenresolution get 04:34:49 INFO - 2017-04-08 04:34:49.724 screenresolution[1670:12185] Display 0: 1600x1200x32@60 04:34:49 INFO - 2017-04-08 04:34:49.730 screenresolution[1671:12187] starting screenresolution argv=screenresolution list 04:34:49 INFO - Available Modes on Display 0 04:34:49 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:34:49 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:34:49 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:34:49 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:34:49 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:34:49 INFO - Intel Iris: 04:34:49 INFO - Chipset Model: Intel Iris 04:34:49 INFO - Type: GPU 04:34:49 INFO - Bus: Built-In 04:34:49 INFO - VRAM (Dynamic, Max): 1536 MB 04:34:49 INFO - Vendor: Intel (0x8086) 04:34:49 INFO - Device ID: 0x0a2e 04:34:49 INFO - Revision ID: 0x0009 04:34:49 INFO - Displays: 04:34:49 INFO - Display: 04:34:49 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:34:49 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:34:49 INFO - Display Serial Number: 1600x1200 60 04:34:49 INFO - Main Display: Yes 04:34:49 INFO - Mirror: Off 04:34:49 INFO - Online: Yes 04:34:49 INFO - Rotation: Supported 04:34:49 INFO - Return code: 0 04:34:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:34:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:34:49 INFO - Python 2.7.3 04:34:49 INFO - Return code: 0 04:34:49 INFO - grabbing minidump binary from tooltool 04:34:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:34:49 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 0x1064fcd30>, '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 0x106423db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1064f1be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:34:49 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:34:49 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:34:49 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:34:50 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:34:50 INFO - Return code: 0 04:34:50 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:34:50 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:34:50 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:34:50 INFO - ENV: RUST_BACKTRACE is now 1 04:34:50 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:34:50 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:34:50 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0392', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:34:50 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/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0392 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:34:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.mJt7CF34Vv/Render', 04:34:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:34:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:34:50 INFO - 'HOME': '/Users/cltbld', 04:34:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:34:50 INFO - 'LOGNAME': 'cltbld', 04:34:50 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:34:50 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:34:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:34:50 INFO - 'MOZ_NO_REMOTE': '1', 04:34:50 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:34:50 INFO - 'NO_EM_RESTART': '1', 04:34:50 INFO - 'PAGER': '/bin/cat', 04:34:50 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:34:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:34:50 INFO - 'PWD': '/builds/slave/test', 04:34:50 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:34:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:34:50 INFO - 'RUST_BACKTRACE': '1', 04:34:50 INFO - 'SHELL': '/bin/bash', 04:34:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.gABp1l7gK4/Listeners', 04:34:50 INFO - 'TMPDIR': '/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/', 04:34:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:34:50 INFO - 'USER': 'cltbld', 04:34:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:34:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:34:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:34:50 INFO - 'XPC_FLAGS': '0x0', 04:34:50 INFO - 'XPC_SERVICE_NAME': '0', 04:34:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:34:50 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/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0392', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:34:50 INFO - mozversion application_buildid: 20170408030204 04:34:50 INFO - mozversion application_changeset: 35c7be9c2db288d1d449e3cc586c4164d642c5fd 04:34:50 INFO - mozversion application_display_name: Nightly 04:34:50 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:34:50 INFO - mozversion application_name: Firefox 04:34:50 INFO - mozversion application_remotingname: firefox 04:34:50 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:34:50 INFO - mozversion application_vendor: Mozilla 04:34:50 INFO - mozversion application_version: 55.0a1 04:34:50 INFO - mozversion platform_buildid: 20170408030204 04:34:50 INFO - mozversion platform_changeset: 35c7be9c2db288d1d449e3cc586c4164d642c5fd 04:34:50 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:34:50 INFO - mozversion platform_version: 55.0a1 04:34:50 INFO - using testdate: 1491651290 04:34:50 INFO - actual date: 1491651290 04:34:50 INFO - starting webserver on 'localhost:49247' 04:34:50 INFO - SUITE-START | Running 2 tests 04:34:50 INFO - TEST-START | dromaeo_css 04:34:50 INFO - operating with platform_type : mac_ 04:34:50 INFO - Initialising browser for dromaeo_css test... 04:34:50 INFO - TEST-INFO | started process 1681 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/tmpsvY3X_/profile http://localhost:49247/getInfo.html) 04:34:53 INFO - PID 1681 | __metrics Screen width/height:1600/1200 04:34:53 INFO - PID 1681 | colorDepth:24 04:34:53 INFO - PID 1681 | Browser inner width/height: 1024/689 04:34:53 INFO - PID 1681 | __metrics 04:34:53 INFO - PID 1681 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:34:53 INFO - PID 1681 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:34:54 INFO - TEST-INFO | 1681: exit 0 04:34:54 INFO - Browser initialized. 04:34:54 INFO - Running cycle 1/1 for dromaeo_css test... 04:34:54 INFO - TEST-INFO | started process 1685 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/tmpsvY3X_/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:35:06 INFO - PID 1685 | RSS: Main: 237375488 04:35:06 INFO - PID 1685 | 04:38:11 INFO - PID 1685 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49247/tests/dromaeo/cssquery-ext.html) 04:38:13 INFO - PID 1685 | RSS: Main: 430014464 04:38:13 INFO - PID 1685 | 04:39:56 INFO - PID 1685 | ************************* 04:39:56 INFO - PID 1685 | A coding exception was thrown and uncaught in a Task. 04:39:56 INFO - PID 1685 | 04:39:56 ERROR - PID 1685 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:39:56 INFO - PID 1685 | Full stack: 04:39:56 INFO - PID 1685 | ************************* 04:39:56 INFO - PID 1685 | ************************* 04:39:56 INFO - PID 1685 | A coding exception was thrown and uncaught in a Task. 04:39:56 INFO - PID 1685 | 04:39:56 ERROR - PID 1685 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:39:56 INFO - PID 1685 | Full stack: 04:39:56 INFO - PID 1685 | ************************* 04:39:56 INFO - PID 1685 | ************************* 04:39:56 INFO - PID 1685 | A coding exception was thrown and uncaught in a Task. 04:39:56 INFO - PID 1685 | 04:39:56 ERROR - PID 1685 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:39:56 INFO - PID 1685 | Full stack: 04:39:56 INFO - PID 1685 | ************************* 04:39:56 INFO - PID 1685 | ************************* 04:39:56 INFO - PID 1685 | A coding exception was thrown and uncaught in a Task. 04:39:56 INFO - PID 1685 | 04:39:56 ERROR - PID 1685 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:39:56 INFO - PID 1685 | Full stack: 04:39:56 INFO - PID 1685 | ************************* 04:41:16 INFO - PID 1685 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-ext.html (next: http://localhost:49247/tests/dromaeo/cssquery-jquery.html) 04:41:16 INFO - PID 1685 | RSS: Main: 370524160 04:41:16 INFO - PID 1685 | 04:44:19 INFO - PID 1685 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49247/tests/dromaeo/cssquery-mootools.html) 04:44:20 INFO - PID 1685 | RSS: Main: 347152384 04:44:20 INFO - PID 1685 | 04:47:22 INFO - PID 1685 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49247/tests/dromaeo/cssquery-prototype.html) 04:47:22 INFO - PID 1685 | RSS: Main: 359833600 04:47:22 INFO - PID 1685 | 04:50:26 INFO - PID 1685 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49247/tests/dromaeo/cssquery-yui.html) 04:50:27 INFO - PID 1685 | RSS: Main: 335077376 04:50:27 INFO - PID 1685 | 04:53:29 INFO - PID 1685 | Cycle 1(1): loaded http://localhost:49247/tests/dromaeo/cssquery-yui.html (next: http://localhost:49247/tests/dromaeo/cssquery-dojo.html) 04:53:29 INFO - PID 1685 | RSS: Main: 373911552 04:53:29 INFO - PID 1685 | 04:53:29 INFO - PID 1685 | __start_tp_report 04:53:29 INFO - PID 1685 | _x_x_mozilla_page_load 04:53:29 INFO - PID 1685 | _x_x_mozilla_page_load_details 04:53:29 INFO - PID 1685 | |i|pagename|runs| 04:53:29 INFO - PID 1685 | |0;dojo.html;3561.7506774525796;3566.7146628269743;3581.6060233374333;3606.531150950376;3648.890533284001;6250.374962503747;6273.68631568422;6284.717187726552;6293.496520278378;6311.3688631136865;6200.131981522591;6275.623462592248;6284.151639528663;6284.245890493147;6290.874182516347;5020.322256495363;5354.732263386834;5494.395616482184;5512.586556008296;5626.127950167731;5522.779088836442;5560.443955604448;5604.495595396414;5605.131204663263;5652.773889044433;5367.543758780489;5441.401445840955;5446.373667028302;5480.26016487773;5561.749721262553;5503.532199762985;5551.195076713894;5557.221988921514;5565.666060036411;5608.719564021823;5484.533814625722;5484.725763711798;5493.093639549509;5493.587980901409;5516.834494965157;6136.825445958321;6173.845653858644;6294.150289710922;6307.085472606446;6314.336994615545;6559.278479367265;6658.9001164982565;6761.154855643044;6762.120924279861;6769.627670478122;6811.182658081012;6853.520253582251;6876.896846547305;6893.551919125241;6909.792706218822;5579.637323573955;6355.523335749884;6381.489480841568;6382.20222472191;6393.744250229939;6674.199096108401;6766.49251306154;6799.150106236721;6951.374376306157;7020.719171233196;6674.365935236145;6696.665166741644;6704.128463299739;6708.530402871752;6718.899216511756;6825.249222585611;6853.7943861684225;6854.931450685529;6866.382025617719;6880;6442.935570644234;6504.9674751625935;6514.990176522647;6763.797086087426;6788.694508747119;6657.367550082734;6744;6755.2906944771075;6766.864662706718;6772.525923185428;5383.461653834585;5409.891802164014;5422.864428389322;5425.37608175057;5472.671639701631;4769.570738633471;4845.394325709286;4852.80588776445;4863.173260545645;4882.292067650242;6313.494920406357;6325.620462772248;6339.651319177489;6339.683015849281;6345.746170153142;6680.732770689216;6683.699233534503;6691.799246022627;6692.330766923269;6695.598264104169;6247.781327653511;6310.9368906311265;6313.494920406357;6318.684065796691;6342.809715708536;5098.5411312982005;6058.394160583906;6065.272167339859;6067.24159480065;6118.357572454917;7022.227554968949;7050.823729406806;7058.400035996998;7072.823179420556;7084.504084714021;6550.8362290943105;6638.83402914931;6645.102911107132;6772.729090836311;6879.174499060145;5550.722463876871;7042.6126563039525;7048.365647091787;7057.188423331382;7083.291670832876;6756.932430675631;6778.898316525355;6786.8642627148165;6811.863762724817;6817.625030623165;6584.637844918576;6730.629815360202;6832.385085342343;6891.173059232724;6908.896366554606;5833.649981001154;6438.90341644885;6567.868642627216;6588.670566471753;6635.170603674541;6595.538312318092;6607.108040414482;6621.5364924454825;6630.602163870183;6631.071649969104;6468.3855033771715;6469.676516174079;6486.675666216576;6490.156279683611;6493.318201588765;6347.555671103163;6410.166678331787;6534.607923524603;6570.375814297634;6609.834754130993;6470.191226096738;6480.70836812354;6485.54601177913;6498.642574658439;6502.73989040452 04:53:29 INFO - PID 1685 | |1;ext.html;784.4979213303486;805.5488926201326;989.9851502227464;1109.7946879827227;1129.836173754805;36815.079623009435;37591.81204093979;37711.43432848506;37826;37856.43215351765;39874.80062599683;40221.79889100558;40238.59761402385;40305;40310.19379612406;5998.220231369915;8295.211954864293;8388.664453421856;8408.411411201218;8424.241818236358;6091.451769340759;8227.629756660936;8437.451565648244;8440.19818117281;8444.915550844506;8484.236418722314;8525.147485251457;8529.57352132394;8540.188682075193;8540.402171847973;8427.367947403938;8496.575171241413;8513.74458766238;8519;8528.78678033048;8338.416310858242;8397.496150231005;8408.159184081604;8414.11651776567;8414.200650938152;37274.44088338677;37483.4377484338;37494.25011499782;37555.24889502222;37576.81211593925;3593.6226696196786;3626.8367923443507;3640.7633503822167;3645.9453108203397;3648.087978005499;30425.935092271884;30668.539971900438;30760.2309942251;30779.538306925413;30795.846020769975;3128.436881361354;3161.8260995645232;3175.491921292605;3178.284885900654;3209.1977005748563;220500;290185.5490722554;290644;290987.5450622754;291741;39755.80122099429;40659;49140.77148071255;49325.02699891964;49332.75333623309;42336;42363.788181058895;42384.57615423868;42389;42479.477667902975;11731.120165987584;13490.325483725774;13738.038337316291;13816.585502434944;13829.723405531833;11234.7191320216;11360.772784544428;11375.374354410422;11378.203525753283;11393.25943813666;10725.410102444284;12206.450709718085;12656.430460629294;12699.158621999759;12736.108472406842;5560.888782224333;5571.470710282517;5572.275604171513;5584.357798853102;5597.328320601472;980.9852852207223;1009.5608410341525;1043.6224184076946;1067.9786404272027;1083.3608171179042;16887.66224675524;23542.058317667103;23647.52704945926;23697.933592988356;23756.287311380685;1115.1580556679655;1115.676453828397;1144.4792619358172;1151.6832870960552;1156.7744289863565;11911.583094591648;12209.755804883853;12223;12242.265464072185;12330.63008109758;294406;333302;345203;345870;346692;54318.18522722162;54648.726756366756;54690;54702.45297547053;54710.72644636752;1498.303288970634;1525.6872341169812;1536.1627912787558;1538.3615799443105;1547.636305468214;27477.76350064212;28498.430031399672;28663.42673146567;29332.706672932996;29393.706062939098;37020.44469332908;37212.81393593015;37231.627683722814;37252.813735931144;37365.626343736214;297783;298477.5076124605;298634.50682746444;298696;298708;28928.698208580245;29194.41611167807;33407;33512.66487335096;33806.661933380354;42440.9389765246;43672.68981930547;43681.34477982769;43761.78119109384;43932.560674394124;28464.288392790346;29121.41757164887;29370;30093.7868698378;30288.394232114795;25991;29349.55975660324;29684.55473167861;29808.913376064334;29872.402551949275;33885.983420497425;35855.46216806698;35994.74018409343;36021.63978360183;36087.27825443424;29934;30034.849825751604;31142.377152457277;32051;32373.35253294874;22391.888040559694;22820.771792281863;23565.64651530194;23902.760972390748;24195.879020604785 04:53:29 INFO - PID 1685 | |2;jquery.html;381.3117323231566;421.91030535274507;436.10380667727827;436.78815774349437;450.3829753238064;16365.181740912967;20731.481712957164;22375.881205939677;22503.887480562615;22715.977780999852;21600.459988500294;21968.78031219687;22425.55148897025;22614.77385226147;22716.65925011126;5193.87015324618;6119.603619990903;6207.03790912407;6216.627002379849;6302.14920985668;6151.6001459904965;6269.404406581368;6269.749210031593;6279.215098112736;6281.780137695182;3324.5844269466315;3624.9275014499694;3821.866234681787;6239.407256310666;6242.875142497147;6064;6187.381261873777;6207.348228435994;6212.565120441571;6215.782447614311;5931.614445061057;6562.77030303937;6647.734090636369;6649.5012874034155;6655.201375834931;27713.307167320778;28460.715392846014;28786.136415907557;28893.56659650107;29709.40581188386;2264.558411109834;2337.6960995070704;2339.2748248043163;2340.695709557747;2341.040173528845;17992.10039498033;18340.26638934441;19172.520686982938;19310.517237069045;19528.31650892226;2251.79733823955;2268.773122687718;2334.708161479815;2335.497867958397;2346.483773569829;153669;156612;168118;170914;173561.13219433822;17999.73000404995;22792;23461;23973.561586304877;24345.26964191077;32898.67101328956;40421.556170117234;40813.38779918304;40847.79576102101;41101;8782.868256976151;10749.247552671395;10855.837162442569;10875.673729788119;11096.778064438666;8503.532305723245;8520.914790852135;8523.275521580736;8705.303575713928;8713.869291960626;10978.176636752116;11036.282641628268;11083.833742493869;11229.606963756229;11232.887671123184;4305;4412;4447.510773814878;4451.755153466591;4459.308807134899;773.2615352338503;948.1798244518442;952.4523399045577;990.8464188050864;995.930284880066;17921.014344211195;18200.45398638043;19379.80620193808;20928.581428371654;21195.78804211938;968.5593055159885;972.3242346569067;996.4917891875195;1003.4180175498193;1009.3540134314045;10176.847347289797;10584.894151058545;10585;10593.258471906893;10598.417087060287;705577;718793;723404;727536;736375;153246;154087.22956385146;154914.47970361737;161974.19012905096;165151.8712032209;1120.7422292872684;1150.61454412771;1177.8998785103363;1178.1399578307712;1178.3754610056683;17991.460256192335;18079.45761627153;18095.914245145334;18108.72836907474;18348.357807476674;58067;59348;59787.40212597993;62291;62508.37491625026;64418.30352902298;86807;88606;88890;89582.55208723915;10966.725831854268;12396.256224626552;12605.93697031509;12704.936475317565;12832.55086071983;13560.457581697015;13576.86423135756;13808.447662093404;13929.930350348184;13948.232847193502;10389.896101038892;10708.464576771286;10929.56281748753;11575.421228938689;12102.75794484123;10711.303765255234;10827.945860270649;10892.019718225081;11229.38238396896;11239.66281011571;10798;11082.833757493483;11168.385738784445;11222;11307.491162897853;10023.498825058863;11114.277571957797;11324;11779.764404711686;11873.168878178445;11397.316161030365;11509.309441433541;11659.475323610628;11684.47419866125;11772.058235341323 04:53:29 INFO - PID 1685 | |3;mootools.html;1327.2368388176799;1389.5483967710497;1412.399730114701;1413.6253892718432;1415.922124283164;11281.32312061277;11771.823422648657;11782.528698852035;11788.941055294734;11799.882001179996;11253.437328133601;11665.825012624797;11764.823527647091;11768.470418831152;11786.17496775226;2355.9764402355972;2403.9158629447884;2409.9879500602474;2411.5418070566534;2412.8311018228733;2089.279198676454;2340.6137987232087;2442.963355549668;2443.2792326263793;2444.8166387521005;2144.3888491779844;2396.8442051266697;2499.6375525548783;2501.062101711858;2501.524710305045;2453.852768833876;2483.714372847128;2487.838290511111;2490.464550121714;2492.239866840613;2056.5578400643785;2445.119756887537;2455.815813813971;2456.2631210636737;2459.717132529764;11553.960143587034;11851.407429628483;11865.110116741278;11871.88128118725;11873.643790686294;6392.3927226913365;6654.467642588581;6656.733730650768;6658.367455091807;6670.3329667033395;3908.9413658795143;4149.875503734893;4243.915121697549;4309.870703878889;4327.740335579875;1242.2670624331688;1253.160382543698;1281.923084614926;1282.4036822877313;1294.139397300794;16638.83361166385;16674.249658765264;16714.916425417916;16720.41478548245;16728.41450549225;5361.919571206435;5403;5599.552035837123;5647.548196144298;5713.857153571111;12407.565735199225;12411.069169812301;12425.37873106341;12438.315892625993;12452.626421207378;6526.934730652728;6527.738890444329;6533;6536.57512261711;6543.803685889431;6072.423119803611;6096.664683442454;6107.051860370598;6161.322254551996;6172.043333283348;4249.91500170001;4341.696081274281;4360.825566977349;4395.27477966132;4409.9559004410185;1247.7255003899127;1274.7195616964252;1279.2580303423993;1292.6122163350958;1299;669.4568968937208;675.9425448836805;733.1422235983912;754.2645920227844;764.6520833020962;6283.403076707706;6484.25431075423;6599.769008084694;6632.9336706633285;6774.830629234309;583.1398686936734;593.2880543347914;596.7374355283662;602.8553147244629;719.8769918926491;3687.3178461984617;4103.199876024206;4135.255653982312;4301.634361079344;4311.353297005474;14753.48362807318;15416.537503874903;15428.768568471482;15441.382344706086;15450.690986180438;14780.778288325684;14923.701525969636;15000.62498437526;15208.923955380153;15363.692726145639;10743.409112498888;10802.567897284021;10917.01746842772;10919.12646988239;10967.287126336763;6414.583052101599;6495.740170393131;6579.374959378852;6615.140031795836;6667.566608170453;12550.30973296441;13436.731265374834;13469.932650336686;13769.105008174436;13925.860741392862;11102.722431939266;13902;13927.23400212998;14047.628569143537;14098.647533811736;8699.130086991503;8714.30285577165;8818.382713210014;8842.778930526789;8845.823083538164;10771.569137234736;10782.24524283324;10907.83638245411;10911.945440273066;10916.836247456453;9067.954660226656;9146.268298536233;9181.311401644769;9278.443293402417;9288.767780805534;8996.190342869173;9007.594658240527;9024.729258122266;9099.408538444979;9267.582958766738;7499.400047996256;8266.751997440086;8272;8281.337493000667;8282.544460054754;5633;5862.355140934579;5869.501092407022;6033.245844269466;6103.565662069322;5926.348101708722;5945.137954996588;6049.3950604939155;6145.262568491809;6294.213223347082 04:53:29 INFO - PID 1685 | |4;prototype.html;378.77841462744294;390.2760379496035;403.81828177320216;404.4075429495788;407.65553107624066;5820.457578741637;6011.947909115898;6116.969415152924;6133.417325354089;6135.539834512407;5834.387389324123;5871.207387002753;5937.703114844262;5990.101484777286;6021.729022194001;4611.44662640482;4613.538646135376;4617.584417402433;4618.960733834885;4621.306803979413;4014.658754005913;4486.573775491323;4572.337011133383;4596.172688915994;4648.907021859561;3959.0402750638473;4554;4557.544245575449;4562.931556026662;4593.402857628504;4561.452625684906;4562.178807814592;4571.38286331346;4577.5880170784785;4578.610818080434;3513.209527856212;3955.0903292242947;4064.309067458539;4073.429719839225;4098.446709694183;4849.806007759686;5882.235349385782;5896.587238893279;5926.555508336849;5929.762809487615;4544.795484203219;5443.8094666686475;5493.835184944418;5494.560435165177;5506.559475241971;4994.751312171957;6093.969530152365;6417.1657684500715;6422.293547709795;6422.7109780059545;4417.514073451917;4660.487346391894;4661.930071048937;4674.368960190399;4682.6019788318035;6156.415140561639;6288.779892703734;6516.5112616553;6689.397954184098;6777.559458635223;4672;4737.526247375235;4741.051789642085;4751.121042607059;4755.429348478205;4248.874048377183;4802.471728109905;4805.255185446262;4831.541003604652;4842.418909730784;5045.66289933168;5188.558972487305;5190.377154741455;5273.604479664041;5463.836084917459;6191.876162476815;6405.423511883952;6486.664800671754;6533.738650454024;6536.411722944958;1262.722201115753;1428.557147284345;1591.5225432370244;1614.3784642912563;1619.4170098764434;975.9703512793928;1056.144522936424;1079.2930630437077;1093.147345070846;1152.6023521884936;5761.625494342854;5954.345022047572;5985.311689155716;5994.670293133832;6030.969845150834;6475.384838440341;6561.770338038145;6625.503087268474;6626.337366263431;6635.170603674541;5212.139996900545;5891.9705401473575;6035.094735789667;6040.546958978094;6105.961986462312;3081.553174789643;3382.661733826598;3410.2497450560836;3425.3149370126075;3427.6572342765526;5675.318961724537;6148.938510614926;6547.541672082908;6659.567128136752;6721.764738234237;6366.936330636727;6732.326767323327;6734.966325168441;6755.763548275787;6766.864662706718;6145.508359331243;6608.471322294205;6656.567323123982;6685.431738302202;6716.83207919806;5985.6408615483215;5987.31145918225;6267.780627678192;6486;6540.738370465128;5663.490285874291;6141.447269745744;6372;6380.393862583047;6479.023897711055;6449.322821103717;6704.061431399706;6735.461163106842;6745.494087943522;6752.831179220559;3506.089945345306;4081.0614957894763;4513.526079761577;4606.930896036495;4623.093486004321;6534.183227096613;6534.4772418205475;6534.863265632618;6541.574797638138;6593.538452308292;6105.358937311518;6204.177099419663;6259.749610015549;6349.9682501587195;6351.237851457669;6090.786822461193;6171.6297022178815;6258.968705156445;6259.593126446948;6287.46556542699;4975.825846095514;5268.315119034501;6154.015247649419;6176.969115154396;6216.471599913877;6036.215292012011;6213.79989305517;6342.49260059185;6352.269489008639;6369.299377068426;5184.896302074013;6227.19046523949;6232.314445411092;6237.970734828702;6267.905981410374 04:53:29 INFO - PID 1685 | |5;yui.html;675.4933799650262;690.9101816763823;753.8303881626634;844.8901642786437;871.65569600008;15134.016288941224;15798.289076991534;15816.288267027983;15823.20883955802;15830.208489575518;14441.205733684643;15065.171415572138;15228;15240.466583669573;15257.237138143104;925.4401087342162;952.1383148250844;956.5934477846922;957.6696039866235;959.184693010942;978.7944531648327;982.2191357870474;982.7002764156929;982.7297493189394;983.9114479696826;1033.0495943731785;1034.105498743589;1034.1261633919326;1036.4040676610941;1036.8392899100613;1002.8846682631518;1010.0404615615195;1013.6958912326272;1013.8073765984476;1020.8264595018865;754.7584772872683;754.8414832885101;755.5466719968031;757.0914902117481;758.1205801270555;13783.862161378458;13954.372053257628;13960.860391396058;13985.300734963314;15096.773548396783;16331.83668163315;16574.83425165757;16890.408835690814;16926.661466770594;17088.57278568033;13337.466501340032;13554.86445135546;13597.184168949894;13713.794293085612;13720.245386503739;3391.423458012119;3421.196018935548;3421.9144521386916;3422.469517224834;3423.4180189367867;92933;119684;120998.58002839983;121062;121145.18282225773;11236.606718764804;11913.689494155637;13395.866041339463;13792;13829.03196776216;23989.76010239875;24377;24766;24829.379265518506;25343.746562534507;8205.343572514184;8600.139986001475;8722.738317850475;8746.169113934293;8774.60514276859;4511.661625378109;4590.081983603226;4594.65540084495;4597.0346227291975;4597.770111494478;4162.666986641061;4177.164567086595;4299.570042995738;4301.978490107529;4308.3968244445805;909.6952520905571;930.330162283155;936.1106948399048;942.665353799405;945.579217248318;585.913131141726;633.4678869749432;668.9966550167218;673.6598018000976;689.4449967775888;9659.855102173473;9952.950235248922;11281;11587.88412115868;11631.185816992898;512.9743512824344;619.704816932613;644.365300179323;654.4894981914115;680.2890978927034;5187.559057480081;5194.298769666122;5194.948050519522;5285.947140528622;5293.920591191135;97614.51192744133;101330;102129;103869;105622.4718876416;81614;88365;89166;89277.66083508753;90979.54510227406;52829.530214726285;70989.2901070993;71285;75143.62428187823;76839;10337.586496540054;11395.74646788836;12158.513659453523;12163.513459461523;12286.262824230575;29541.55687664644;36412.81793591015;36420.81789591035;36627;37756;47243.52756472391;47413.288800668706;47456.28815567838;47690;47694.13835169901;15398.15310157952;15631.531054068397;15777.68444631078;15803.288852001457;15981.760273596137;16160.191990400197;17568.824311756718;17610.20754066096;17663.470095897144;17990.730139047664;14611.85388146105;16065.839341606434;16160.515184544482;16182.514524564282;16205.027698338137;15937.840621593636;16126.516204513884;16163.919180404022;16170.191490425666;16295.022298662117;15481.612959676098;15671.529854104396;15891;15950.282237299582;16002.119883406524;11067.612633557786;11193;11324.150688698215;11480.425978700865;11492;11472.73799882029;11744.412779361168;12349.567765128537;12481.251124932533;12569.86871181598 04:53:29 INFO - PID 1685 | __end_tp_report 04:53:29 INFO - PID 1685 | __start_cc_report 04:53:29 INFO - PID 1685 | _x_x_mozilla_cycle_collect,2117 04:53:29 INFO - PID 1685 | __end_cc_report 04:53:29 INFO - PID 1685 | __startTimestamp1491652409792__endTimestamp 04:53:29 INFO - PID 1685 | 04:53:29 INFO - PID 1685 | ------- Summary: start ------- 04:53:29 INFO - PID 1685 | Number of tests: 6 04:53:29 INFO - PID 1685 | 04:53:29 INFO - PID 1685 | [#0] dojo.html Cycles:165 Average:6226.72 Median:6469.68 stddev:733.17 (11.3%) stddev-sans-first:704.98 04:53:29 INFO - PID 1685 | Values: 3561.8 3566.7 3581.6 3606.5 3648.9 6250.4 6273.7 6284.7 6293.5 6311.4 6200.1 6275.6 6284.2 6284.2 6290.9 5020.3 5354.7 5494.4 5512.6 5626.1 5522.8 5560.4 5604.5 5605.1 5652.8 5367.5 5441.4 5446.4 5480.3 5561.7 5503.5 5551.2 5557.2 5565.7 5608.7 5484.5 5484.7 5493.1 5493.6 5516.8 6136.8 6173.8 6294.2 6307.1 6314.3 6559.3 6658.9 6761.2 6762.1 6769.6 6811.2 6853.5 6876.9 6893.6 6909.8 5579.6 6355.5 6381.5 6382.2 6393.7 6674.2 6766.5 6799.2 6951.4 7020.7 6674.4 6696.7 6704.1 6708.5 6718.9 6825.2 6853.8 6854.9 6866.4 6880.0 6442.9 6505.0 6515.0 6763.8 6788.7 6657.4 6744.0 6755.3 6766.9 6772.5 5383.5 5409.9 5422.9 5425.4 5472.7 4769.6 4845.4 4852.8 4863.2 4882.3 6313.5 6325.6 6339.7 6339.7 6345.7 6680.7 6683.7 6691.8 6692.3 6695.6 6247.8 6310.9 6313.5 6318.7 6342.8 5098.5 6058.4 6065.3 6067.2 6118.4 7022.2 7050.8 7058.4 7072.8 7084.5 6550.8 6638.8 6645.1 6772.7 6879.2 5550.7 7042.6 7048.4 7057.2 7083.3 6756.9 6778.9 6786.9 6811.9 6817.6 6584.6 6730.6 6832.4 6891.2 6908.9 5833.6 6438.9 6567.9 6588.7 6635.2 6595.5 6607.1 6621.5 6630.6 6631.1 6468.4 6469.7 6486.7 6490.2 6493.3 6347.6 6410.2 6534.6 6570.4 6609.8 6470.2 6480.7 6485.5 6498.6 6502.7 04:53:29 INFO - PID 1685 | 04:53:29 INFO - PID 1685 | [#1] ext.html Cycles:180 Average:44894.48 Median:33459.83 stddev:79919.55 (238.9%) stddev-sans-first:80075.13 04:53:29 INFO - PID 1685 | Values: 784.5 805.5 990.0 1109.8 1129.8 36815.1 37591.8 37711.4 37826.0 37856.4 39874.8 40221.8 40238.6 40305.0 40310.2 5998.2 8295.2 8388.7 8408.4 8424.2 6091.5 8227.6 8437.5 8440.2 8444.9 8484.2 8525.1 8529.6 8540.2 8540.4 8427.4 8496.6 8513.7 8519.0 8528.8 8338.4 8397.5 8408.2 8414.1 8414.2 37274.4 37483.4 37494.3 37555.2 37576.8 3593.6 3626.8 3640.8 3645.9 3648.1 30425.9 30668.5 30760.2 30779.5 30795.8 3128.4 3161.8 3175.5 3178.3 3209.2 220500.0 290185.5 290644.0 290987.5 291741.0 39755.8 40659.0 49140.8 49325.0 49332.8 42336.0 42363.8 42384.6 42389.0 42479.5 11731.1 13490.3 13738.0 13816.6 13829.7 11234.7 11360.8 11375.4 11378.2 11393.3 10725.4 12206.5 12656.4 12699.2 12736.1 5560.9 5571.5 5572.3 5584.4 5597.3 981.0 1009.6 1043.6 1068.0 1083.4 16887.7 23542.1 23647.5 23697.9 23756.3 1115.2 1115.7 1144.5 1151.7 1156.8 11911.6 12209.8 12223.0 12242.3 12330.6 294406.0 333302.0 345203.0 345870.0 346692.0 54318.2 54648.7 54690.0 54702.5 54710.7 1498.3 1525.7 1536.2 1538.4 1547.6 27477.8 28498.4 28663.4 29332.7 29393.7 37020.4 37212.8 37231.6 37252.8 37365.6 297783.0 298477.5 298634.5 298696.0 298708.0 28928.7 29194.4 33407.0 33512.7 33806.7 42440.9 43672.7 43681.3 43761.8 43932.6 28464.3 29121.4 29370.0 30093.8 30288.4 25991.0 29349.6 29684.6 29808.9 29872.4 33886.0 35855.5 35994.7 36021.6 36087.3 29934.0 30034.8 31142.4 32051.0 32373.4 22391.9 22820.8 23565.6 23902.8 24195.9 04:53:29 INFO - PID 1685 | 04:53:29 INFO - PID 1685 | [#2] jquery.html Cycles:180 Average:42887.80 Median:12439.67 stddev:121097.33 (973.5%) stddev-sans-first:121394.99 04:53:29 INFO - PID 1685 | Values: 381.3 421.9 436.1 436.8 450.4 16365.2 20731.5 22375.9 22503.9 22716.0 21600.5 21968.8 22425.6 22614.8 22716.7 5193.9 6119.6 6207.0 6216.6 6302.1 6151.6 6269.4 6269.7 6279.2 6281.8 3324.6 3624.9 3821.9 6239.4 6242.9 6064.0 6187.4 6207.3 6212.6 6215.8 5931.6 6562.8 6647.7 6649.5 6655.2 27713.3 28460.7 28786.1 28893.6 29709.4 2264.6 2337.7 2339.3 2340.7 2341.0 17992.1 18340.3 19172.5 19310.5 19528.3 2251.8 2268.8 2334.7 2335.5 2346.5 153669.0 156612.0 168118.0 170914.0 173561.1 17999.7 22792.0 23461.0 23973.6 24345.3 32898.7 40421.6 40813.4 40847.8 41101.0 8782.9 10749.2 10855.8 10875.7 11096.8 8503.5 8520.9 8523.3 8705.3 8713.9 10978.2 11036.3 11083.8 11229.6 11232.9 4305.0 4412.0 4447.5 4451.8 4459.3 773.3 948.2 952.5 990.8 995.9 17921.0 18200.5 19379.8 20928.6 21195.8 968.6 972.3 996.5 1003.4 1009.4 10176.8 10584.9 10585.0 10593.3 10598.4 705577.0 718793.0 723404.0 727536.0 736375.0 153246.0 154087.2 154914.5 161974.2 165151.9 1120.7 1150.6 1177.9 1178.1 1178.4 17991.5 18079.5 18095.9 18108.7 18348.4 58067.0 59348.0 59787.4 62291.0 62508.4 64418.3 86807.0 88606.0 88890.0 89582.6 10966.7 12396.3 12605.9 12704.9 12832.6 13560.5 13576.9 13808.4 13929.9 13948.2 10389.9 10708.5 10929.6 11575.4 12102.8 10711.3 10827.9 10892.0 11229.4 11239.7 10798.0 11082.8 11168.4 11222.0 11307.5 10023.5 11114.3 11324.0 11779.8 11873.2 11397.3 11509.3 11659.5 11684.5 11772.1 04:53:29 INFO - PID 1685 | 04:53:29 INFO - PID 1685 | [#3] mootools.html Cycles:180 Average:7172.07 Median:2491.35 stddev:4615.73 (185.3%) stddev-sans-first:4607.78 04:53:29 INFO - PID 1685 | Values: 1327.2 1389.5 1412.4 1413.6 1415.9 11281.3 11771.8 11782.5 11788.9 11799.9 11253.4 11665.8 11764.8 11768.5 11786.2 2356.0 2403.9 2410.0 2411.5 2412.8 2089.3 2340.6 2443.0 2443.3 2444.8 2144.4 2396.8 2499.6 2501.1 2501.5 2453.9 2483.7 2487.8 2490.5 2492.2 2056.6 2445.1 2455.8 2456.3 2459.7 11554.0 11851.4 11865.1 11871.9 11873.6 6392.4 6654.5 6656.7 6658.4 6670.3 3908.9 4149.9 4243.9 4309.9 4327.7 1242.3 1253.2 1281.9 1282.4 1294.1 16638.8 16674.2 16714.9 16720.4 16728.4 5361.9 5403.0 5599.6 5647.5 5713.9 12407.6 12411.1 12425.4 12438.3 12452.6 6526.9 6527.7 6533.0 6536.6 6543.8 6072.4 6096.7 6107.1 6161.3 6172.0 4249.9 4341.7 4360.8 4395.3 4410.0 1247.7 1274.7 1279.3 1292.6 1299.0 669.5 675.9 733.1 754.3 764.7 6283.4 6484.3 6599.8 6632.9 6774.8 583.1 593.3 596.7 602.9 719.9 3687.3 4103.2 4135.3 4301.6 4311.4 14753.5 15416.5 15428.8 15441.4 15450.7 14780.8 14923.7 15000.6 15208.9 15363.7 10743.4 10802.6 10917.0 10919.1 10967.3 6414.6 6495.7 6579.4 6615.1 6667.6 12550.3 13436.7 13469.9 13769.1 13925.9 11102.7 13902.0 13927.2 14047.6 14098.6 8699.1 8714.3 8818.4 8842.8 8845.8 10771.6 10782.2 10907.8 10911.9 10916.8 9068.0 9146.3 9181.3 9278.4 9288.8 8996.2 9007.6 9024.7 9099.4 9267.6 7499.4 8266.8 8272.0 8281.3 8282.5 5633.0 5862.4 5869.5 6033.2 6103.6 5926.3 5945.1 6049.4 6145.3 6294.2 04:53:29 INFO - PID 1685 | 04:53:29 INFO - PID 1685 | [#4] prototype.html Cycles:180 Average:5223.37 Median:5933.73 stddev:1572.72 (26.5%) stddev-sans-first:1534.52 04:53:29 INFO - PID 1685 | Values: 378.8 390.3 403.8 404.4 407.7 5820.5 6011.9 6117.0 6133.4 6135.5 5834.4 5871.2 5937.7 5990.1 6021.7 4611.4 4613.5 4617.6 4619.0 4621.3 4014.7 4486.6 4572.3 4596.2 4648.9 3959.0 4554.0 4557.5 4562.9 4593.4 4561.5 4562.2 4571.4 4577.6 4578.6 3513.2 3955.1 4064.3 4073.4 4098.4 4849.8 5882.2 5896.6 5926.6 5929.8 4544.8 5443.8 5493.8 5494.6 5506.6 4994.8 6094.0 6417.2 6422.3 6422.7 4417.5 4660.5 4661.9 4674.4 4682.6 6156.4 6288.8 6516.5 6689.4 6777.6 4672.0 4737.5 4741.1 4751.1 4755.4 4248.9 4802.5 4805.3 4831.5 4842.4 5045.7 5188.6 5190.4 5273.6 5463.8 6191.9 6405.4 6486.7 6533.7 6536.4 1262.7 1428.6 1591.5 1614.4 1619.4 976.0 1056.1 1079.3 1093.1 1152.6 5761.6 5954.3 5985.3 5994.7 6031.0 6475.4 6561.8 6625.5 6626.3 6635.2 5212.1 5892.0 6035.1 6040.5 6106.0 3081.6 3382.7 3410.2 3425.3 3427.7 5675.3 6148.9 6547.5 6659.6 6721.8 6366.9 6732.3 6735.0 6755.8 6766.9 6145.5 6608.5 6656.6 6685.4 6716.8 5985.6 5987.3 6267.8 6486.0 6540.7 5663.5 6141.4 6372.0 6380.4 6479.0 6449.3 6704.1 6735.5 6745.5 6752.8 3506.1 4081.1 4513.5 4606.9 4623.1 6534.2 6534.5 6534.9 6541.6 6593.5 6105.4 6204.2 6259.7 6350.0 6351.2 6090.8 6171.6 6259.0 6259.6 6287.5 4975.8 5268.3 6154.0 6177.0 6216.5 6036.2 6213.8 6342.5 6352.3 6369.3 5184.9 6227.2 6232.3 6238.0 6267.9 04:53:29 INFO - PID 1685 | 04:53:29 INFO - PID 1685 | [#5] yui.html Cycles:180 Average:20299.20 Median:20990.25 stddev:28481.65 (135.7%) stddev-sans-first:28523.43 04:53:29 INFO - PID 1685 | Values: 675.5 690.9 753.8 844.9 871.7 15134.0 15798.3 15816.3 15823.2 15830.2 14441.2 15065.2 15228.0 15240.5 15257.2 925.4 952.1 956.6 957.7 959.2 978.8 982.2 982.7 982.7 983.9 1033.0 1034.1 1034.1 1036.4 1036.8 1002.9 1010.0 1013.7 1013.8 1020.8 754.8 754.8 755.5 757.1 758.1 13783.9 13954.4 13960.9 13985.3 15096.8 16331.8 16574.8 16890.4 16926.7 17088.6 13337.5 13554.9 13597.2 13713.8 13720.2 3391.4 3421.2 3421.9 3422.5 3423.4 92933.0 119684.0 120998.6 121062.0 121145.2 11236.6 11913.7 13395.9 13792.0 13829.0 23989.8 24377.0 24766.0 24829.4 25343.7 8205.3 8600.1 8722.7 8746.2 8774.6 4511.7 4590.1 4594.7 4597.0 4597.8 4162.7 4177.2 4299.6 4302.0 4308.4 909.7 930.3 936.1 942.7 945.6 585.9 633.5 669.0 673.7 689.4 9659.9 9953.0 11281.0 11587.9 11631.2 513.0 619.7 644.4 654.5 680.3 5187.6 5194.3 5194.9 5285.9 5293.9 97614.5 101330.0 102129.0 103869.0 105622.5 81614.0 88365.0 89166.0 89277.7 90979.5 52829.5 70989.3 71285.0 75143.6 76839.0 10337.6 11395.7 12158.5 12163.5 12286.3 29541.6 36412.8 36420.8 36627.0 37756.0 47243.5 47413.3 47456.3 47690.0 47694.1 15398.2 15631.5 15777.7 15803.3 15981.8 16160.2 17568.8 17610.2 17663.5 17990.7 14611.9 16065.8 16160.5 16182.5 16205.0 15937.8 16126.5 16163.9 16170.2 16295.0 15481.6 15671.5 15891.0 15950.3 16002.1 11067.6 11193.0 11324.2 11480.4 11492.0 11472.7 11744.4 12349.6 12481.3 12569.9 04:53:29 INFO - PID 1685 | -------- Summary: end -------- 04:53:29 INFO - PID 1685 | 04:53:30 INFO - TEST-INFO | 1685: exit 0 04:53:30 INFO - TEST-OK | dromaeo_css | took 1120135ms 04:53:30 INFO - TEST-START | kraken 04:53:30 INFO - operating with platform_type : mac_ 04:53:30 INFO - Initialising browser for kraken test... 04:53:30 INFO - TEST-INFO | started process 1690 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/tmpAD0M1K/profile http://localhost:49247/getInfo.html) 04:53:32 INFO - PID 1690 | __metrics Screen width/height:1600/1200 04:53:32 INFO - PID 1690 | colorDepth:24 04:53:32 INFO - PID 1690 | Browser inner width/height: 1024/689 04:53:32 INFO - PID 1690 | __metrics 04:53:33 INFO - PID 1690 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:53:33 INFO - PID 1690 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 304: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:53:33 INFO - TEST-INFO | 1690: exit 0 04:53:33 INFO - Browser initialized. 04:53:33 INFO - Running cycle 1/1 for kraken test... 04:53:34 INFO - TEST-INFO | started process 1692 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/T/tmpAD0M1K/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:53:46 INFO - PID 1692 | RSS: Main: 239345664 04:53:46 INFO - PID 1692 | 04:53:49 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection) 04:53:50 INFO - PID 1692 | RSS: Main: 292077568 04:53:50 INFO - PID 1692 | 04:53:52 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-dft) 04:53:53 INFO - PID 1692 | RSS: Main: 291848192 04:53:53 INFO - PID 1692 | 04:53:57 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-fft) 04:53:58 INFO - PID 1692 | RSS: Main: 385769472 04:53:58 INFO - PID 1692 | 04:54:00 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator) 04:54:00 INFO - PID 1692 | RSS: Main: 287711232 04:54:00 INFO - PID 1692 | 04:54:02 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:54:03 INFO - PID 1692 | RSS: Main: 292126720 04:54:03 INFO - PID 1692 | 04:54:06 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom) 04:54:07 INFO - PID 1692 | RSS: Main: 332636160 04:54:07 INFO - PID 1692 | 04:54:10 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate) 04:54:10 INFO - PID 1692 | RSS: Main: 345096192 04:54:10 INFO - PID 1692 | 04:54:14 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial) 04:54:14 INFO - PID 1692 | RSS: Main: 349589504 04:54:14 INFO - PID 1692 | 04:54:16 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:54:16 INFO - PID 1692 | RSS: Main: 309125120 04:54:16 INFO - PID 1692 | 04:54:18 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:54:19 INFO - PID 1692 | RSS: Main: 312614912 04:54:19 INFO - PID 1692 | 04:54:21 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:54:22 INFO - PID 1692 | RSS: Main: 315056128 04:54:22 INFO - PID 1692 | 04:54:25 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:54:26 INFO - PID 1692 | RSS: Main: 334086144 04:54:26 INFO - PID 1692 | 04:54:29 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:54:29 INFO - PID 1692 | RSS: Main: 327434240 04:54:29 INFO - PID 1692 | 04:54:31 INFO - PID 1692 | Cycle 1(1): loaded http://localhost:49247/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49247/tests/kraken/driver.html?testName=ai-astar) 04:54:32 INFO - PID 1692 | RSS: Main: 390004736 04:54:32 INFO - PID 1692 | 04:54:32 INFO - PID 1692 | __start_tp_report 04:54:32 INFO - PID 1692 | _x_x_mozilla_page_load 04:54:32 INFO - PID 1692 | _x_x_mozilla_page_load_details 04:54:32 INFO - PID 1692 | |i|pagename|runs| 04:54:32 INFO - PID 1692 | |0;ai-astar;110;122;125;123;124;124;124;123;125;124 04:54:32 INFO - PID 1692 | |1;audio-beat-detection;188;157;120;161;117;119;120;122;146;120 04:54:32 INFO - PID 1692 | |2;audio-dft;217;250;296;218;210;217;210;214;209;206 04:54:32 INFO - PID 1692 | |3;audio-fft;85;65;61;98;68;69;66;61;83;62 04:54:32 INFO - PID 1692 | |4;audio-oscillator;92;76;95;76;76;73;92;74;75;92 04:54:32 INFO - PID 1692 | |5;imaging-gaussian-blur;93;94;92;93;93;93;92;92;94;92 04:54:32 INFO - PID 1692 | |6;imaging-darkroom;101;103;101;102;100;102;100;102;102;102 04:54:32 INFO - PID 1692 | |7;imaging-desaturate;100;101;101;103;101;100;100;98;101;100 04:54:32 INFO - PID 1692 | |8;json-parse-financial;53;51;51;51;52;52;51;52;52;51 04:54:32 INFO - PID 1692 | |9;json-stringify-tinderbox;60;70;71;69;66;63;65;63;66;65 04:54:32 INFO - PID 1692 | |10;stanford-crypto-aes;89;90;92;91;89;91;89;88;90;91 04:54:32 INFO - PID 1692 | |11;stanford-crypto-ccm;151;151;155;154;148;150;164;150;204;149 04:54:32 INFO - PID 1692 | |12;stanford-crypto-pbkdf2;199;207;218;197;197;198;196;199;201;199 04:54:32 INFO - PID 1692 | |13;stanford-crypto-sha256-iterative;70;73;73;72;72;74;87;105;76;72 04:54:32 INFO - PID 1692 | __end_tp_report 04:54:32 INFO - PID 1692 | __start_cc_report 04:54:32 INFO - PID 1692 | _x_x_mozilla_cycle_collect,2139 04:54:32 INFO - PID 1692 | __end_cc_report 04:54:32 INFO - PID 1692 | __startTimestamp1491652472124__endTimestamp 04:54:32 INFO - PID 1692 | 04:54:32 INFO - PID 1692 | ------- Summary: start ------- 04:54:32 INFO - PID 1692 | Number of tests: 14 04:54:32 INFO - PID 1692 | 04:54:32 INFO - PID 1692 | [#0] ai-astar Cycles:10 Average:122.40 Median:124.00 stddev:4.45 (3.6%) stddev-sans-first:0.97 04:54:32 INFO - PID 1692 | Values: 110.0 122.0 125.0 123.0 124.0 124.0 124.0 123.0 125.0 124.0 04:54:32 INFO - PID 1692 | 04:54:32 INFO - PID 1692 | [#1] audio-beat-detection Cycles:10 Average:137.00 Median:134.00 stddev:24.66 (18.4%) stddev-sans-first:17.97 04:54:32 INFO - PID 1692 | Values: 188.0 157.0 120.0 161.0 117.0 119.0 120.0 122.0 146.0 120.0 04:54:32 INFO - PID 1692 | 04:54:32 INFO - PID 1692 | [#2] audio-dft Cycles:10 Average:224.70 Median:217.00 stddev:27.95 (12.9%) stddev-sans-first:29.50 04:54:32 INFO - PID 1692 | Values: 217.0 250.0 296.0 218.0 210.0 217.0 210.0 214.0 209.0 206.0 04:54:32 INFO - PID 1692 | 04:54:32 INFO - PID 1692 | [#3] audio-fft Cycles:10 Average:71.80 Median:68.50 stddev:12.55 (18.3%) stddev-sans-first:12.37 04:54:32 INFO - PID 1692 | Values: 85.0 65.0 61.0 98.0 68.0 69.0 66.0 61.0 83.0 62.0 04:54:32 INFO - PID 1692 | 04:54:32 INFO - PID 1692 | [#4] audio-oscillator Cycles:10 Average:82.10 Median:84.00 stddev:9.26 (11.0%) stddev-sans-first:9.10 04:54:32 INFO - PID 1692 | Values: 92.0 76.0 95.0 76.0 76.0 73.0 92.0 74.0 75.0 92.0 04:54:32 INFO - PID 1692 | 04:54:32 INFO - PID 1692 | [#5] imaging-gaussian-blur Cycles:10 Average:92.80 Median:93.00 stddev:0.79 (0.8%) stddev-sans-first:0.83 04:54:32 INFO - PID 1692 | Values: 93.0 94.0 92.0 93.0 93.0 93.0 92.0 92.0 94.0 92.0 04:54:32 INFO - PID 1692 | 04:54:32 INFO - PID 1692 | [#6] imaging-darkroom Cycles:10 Average:101.50 Median:102.00 stddev:0.97 (1.0%) stddev-sans-first:1.01 04:54:32 INFO - PID 1692 | Values: 101.0 103.0 101.0 102.0 100.0 102.0 100.0 102.0 102.0 102.0 04:54:32 INFO - PID 1692 | 04:54:32 INFO - PID 1692 | [#7] imaging-desaturate Cycles:10 Average:100.50 Median:101.00 stddev:1.27 (1.3%) stddev-sans-first:1.33 04:54:32 INFO - PID 1692 | Values: 100.0 101.0 101.0 103.0 101.0 100.0 100.0 98.0 101.0 100.0 04:54:32 INFO - PID 1692 | 04:54:32 INFO - PID 1692 | [#8] json-parse-financial Cycles:10 Average:51.60 Median:52.00 stddev:0.70 (1.3%) stddev-sans-first:0.53 04:54:32 INFO - PID 1692 | Values: 53.0 51.0 51.0 51.0 52.0 52.0 51.0 52.0 52.0 51.0 04:54:32 INFO - PID 1692 | 04:54:32 INFO - PID 1692 | [#9] json-stringify-tinderbox Cycles:10 Average:65.80 Median:66.00 stddev:3.43 (5.2%) stddev-sans-first:2.92 04:54:32 INFO - PID 1692 | Values: 60.0 70.0 71.0 69.0 66.0 63.0 65.0 63.0 66.0 65.0 04:54:32 INFO - PID 1692 | 04:54:32 INFO - PID 1692 | [#10] stanford-crypto-aes Cycles:10 Average:90.00 Median:90.50 stddev:1.25 (1.4%) stddev-sans-first:1.27 04:54:32 INFO - PID 1692 | Values: 89.0 90.0 92.0 91.0 89.0 91.0 89.0 88.0 90.0 91.0 04:54:32 INFO - PID 1692 | 04:54:32 INFO - PID 1692 | [#11] stanford-crypto-ccm Cycles:10 Average:157.60 Median:152.50 stddev:16.94 (11.1%) stddev-sans-first:17.80 04:54:32 INFO - PID 1692 | Values: 151.0 151.0 155.0 154.0 148.0 150.0 164.0 150.0 204.0 149.0 04:54:32 INFO - PID 1692 | 04:54:32 INFO - PID 1692 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.10 Median:199.00 stddev:6.69 (3.4%) stddev-sans-first:7.05 04:54:32 INFO - PID 1692 | Values: 199.0 207.0 218.0 197.0 197.0 198.0 196.0 199.0 201.0 199.0 04:54:32 INFO - PID 1692 | 04:54:32 INFO - PID 1692 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:77.40 Median:73.00 stddev:10.79 (14.8%) stddev-sans-first:11.11 04:54:32 INFO - PID 1692 | Values: 70.0 73.0 73.0 72.0 72.0 74.0 87.0 105.0 76.0 72.0 04:54:32 INFO - PID 1692 | -------- Summary: end -------- 04:54:32 INFO - PID 1692 | 04:54:33 INFO - TEST-INFO | 1692: exit 0 04:54:33 INFO - TEST-OK | kraken | took 62736ms 04:54:33 INFO - SUITE-END | took 1182s 04:54:33 INFO - Completed test suite (00:19:42) 04:54:33 INFO - javascript benchmark 04:54:33 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7931.250636638202, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3561.7506774525796, 3566.7146628269743, 3581.6060233374333, 3606.531150950376, 3648.890533284001, 6250.374962503747, 6273.68631568422, 6284.717187726552, 6293.496520278378, 6311.3688631136865, 6200.131981522591, 6275.623462592248, 6284.151639528663, 6284.245890493147, 6290.874182516347, 5020.322256495363, 5354.732263386834, 5494.395616482184, 5512.586556008296, 5626.127950167731, 5522.779088836442, 5560.443955604448, 5604.495595396414, 5605.131204663263, 5652.773889044433, 5367.543758780489, 5441.401445840955, 5446.373667028302, 5480.26016487773, 5561.749721262553, 5503.532199762985, 5551.195076713894, 5557.221988921514, 5565.666060036411, 5608.719564021823, 5484.533814625722, 5484.725763711798, 5493.093639549509, 5493.587980901409, 5516.834494965157, 6136.825445958321, 6173.845653858644, 6294.150289710922, 6307.085472606446, 6314.336994615545, 6559.278479367265, 6658.9001164982565, 6761.154855643044, 6762.120924279861, 6769.627670478122, 6811.182658081012, 6853.520253582251, 6876.896846547305, 6893.551919125241, 6909.792706218822, 5579.637323573955, 6355.523335749884, 6381.489480841568, 6382.20222472191, 6393.744250229939, 6674.199096108401, 6766.49251306154, 6799.150106236721, 6951.374376306157, 7020.719171233196, 6674.365935236145, 6696.665166741644, 6704.128463299739, 6708.530402871752, 6718.899216511756, 6825.249222585611, 6853.7943861684225, 6854.931450685529, 6866.382025617719, 6880.0, 6442.935570644234, 6504.9674751625935, 6514.990176522647, 6763.797086087426, 6788.694508747119, 6657.367550082734, 6744.0, 6755.2906944771075, 6766.864662706718, 6772.525923185428, 5383.461653834585, 5409.891802164014, 5422.864428389322, 5425.37608175057, 5472.671639701631, 4769.570738633471, 4845.394325709286, 4852.80588776445, 4863.173260545645, 4882.292067650242, 6313.494920406357, 6325.620462772248, 6339.651319177489, 6339.683015849281, 6345.746170153142, 6680.732770689216, 6683.699233534503, 6691.799246022627, 6692.330766923269, 6695.598264104169, 6247.781327653511, 6310.9368906311265, 6313.494920406357, 6318.684065796691, 6342.809715708536, 5098.5411312982005, 6058.394160583906, 6065.272167339859, 6067.24159480065, 6118.357572454917, 7022.227554968949, 7050.823729406806, 7058.400035996998, 7072.823179420556, 7084.504084714021, 6550.8362290943105, 6638.83402914931, 6645.102911107132, 6772.729090836311, 6879.174499060145, 5550.722463876871, 7042.6126563039525, 7048.365647091787, 7057.188423331382, 7083.291670832876, 6756.932430675631, 6778.898316525355, 6786.8642627148165, 6811.863762724817, 6817.625030623165, 6584.637844918576, 6730.629815360202, 6832.385085342343, 6891.173059232724, 6908.896366554606, 5833.649981001154, 6438.90341644885, 6567.868642627216, 6588.670566471753, 6635.170603674541, 6595.538312318092, 6607.108040414482, 6621.5364924454825, 6630.602163870183, 6631.071649969104, 6468.3855033771715, 6469.676516174079, 6486.675666216576, 6490.156279683611, 6493.318201588765, 6347.555671103163, 6410.166678331787, 6534.607923524603, 6570.375814297634, 6609.834754130993, 6470.191226096738, 6480.70836812354, 6485.54601177913, 6498.642574658439, 6502.73989040452], "value": 6178.105621643166, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [784.4979213303486, 805.5488926201326, 989.9851502227464, 1109.7946879827227, 1129.836173754805, 36815.079623009435, 37591.81204093979, 37711.43432848506, 37826.0, 37856.43215351765, 39874.80062599683, 40221.79889100558, 40238.59761402385, 40305.0, 40310.19379612406, 5998.220231369915, 8295.211954864293, 8388.664453421856, 8408.411411201218, 8424.241818236358, 6091.451769340759, 8227.629756660936, 8437.451565648244, 8440.19818117281, 8444.915550844506, 8484.236418722314, 8525.147485251457, 8529.57352132394, 8540.188682075193, 8540.402171847973, 8427.367947403938, 8496.575171241413, 8513.74458766238, 8519.0, 8528.78678033048, 8338.416310858242, 8397.496150231005, 8408.159184081604, 8414.11651776567, 8414.200650938152, 37274.44088338677, 37483.4377484338, 37494.25011499782, 37555.24889502222, 37576.81211593925, 3593.6226696196786, 3626.8367923443507, 3640.7633503822167, 3645.9453108203397, 3648.087978005499, 30425.935092271884, 30668.539971900438, 30760.2309942251, 30779.538306925413, 30795.846020769975, 3128.436881361354, 3161.8260995645232, 3175.491921292605, 3178.284885900654, 3209.1977005748563, 220500.0, 290185.5490722554, 290644.0, 290987.5450622754, 291741.0, 39755.80122099429, 40659.0, 49140.77148071255, 49325.02699891964, 49332.75333623309, 42336.0, 42363.788181058895, 42384.57615423868, 42389.0, 42479.477667902975, 11731.120165987584, 13490.325483725774, 13738.038337316291, 13816.585502434944, 13829.723405531833, 11234.7191320216, 11360.772784544428, 11375.374354410422, 11378.203525753283, 11393.25943813666, 10725.410102444284, 12206.450709718085, 12656.430460629294, 12699.158621999759, 12736.108472406842, 5560.888782224333, 5571.470710282517, 5572.275604171513, 5584.357798853102, 5597.328320601472, 980.9852852207223, 1009.5608410341525, 1043.6224184076946, 1067.9786404272027, 1083.3608171179042, 16887.66224675524, 23542.058317667103, 23647.52704945926, 23697.933592988356, 23756.287311380685, 1115.1580556679655, 1115.676453828397, 1144.4792619358172, 1151.6832870960552, 1156.7744289863565, 11911.583094591648, 12209.755804883853, 12223.0, 12242.265464072185, 12330.63008109758, 294406.0, 333302.0, 345203.0, 345870.0, 346692.0, 54318.18522722162, 54648.726756366756, 54690.0, 54702.45297547053, 54710.72644636752, 1498.303288970634, 1525.6872341169812, 1536.1627912787558, 1538.3615799443105, 1547.636305468214, 27477.76350064212, 28498.430031399672, 28663.42673146567, 29332.706672932996, 29393.706062939098, 37020.44469332908, 37212.81393593015, 37231.627683722814, 37252.813735931144, 37365.626343736214, 297783.0, 298477.5076124605, 298634.50682746444, 298696.0, 298708.0, 28928.698208580245, 29194.41611167807, 33407.0, 33512.66487335096, 33806.661933380354, 42440.9389765246, 43672.68981930547, 43681.34477982769, 43761.78119109384, 43932.560674394124, 28464.288392790346, 29121.41757164887, 29370.0, 30093.7868698378, 30288.394232114795, 25991.0, 29349.55975660324, 29684.55473167861, 29808.913376064334, 29872.402551949275, 33885.983420497425, 35855.46216806698, 35994.74018409343, 36021.63978360183, 36087.27825443424, 29934.0, 30034.849825751604, 31142.377152457277, 32051.0, 32373.35253294874, 22391.888040559694, 22820.771792281863, 23565.64651530194, 23902.760972390748, 24195.879020604785], "value": 17273.46780033057, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [381.3117323231566, 421.91030535274507, 436.10380667727827, 436.78815774349437, 450.3829753238064, 16365.181740912967, 20731.481712957164, 22375.881205939677, 22503.887480562615, 22715.977780999852, 21600.459988500294, 21968.78031219687, 22425.55148897025, 22614.77385226147, 22716.65925011126, 5193.87015324618, 6119.603619990903, 6207.03790912407, 6216.627002379849, 6302.14920985668, 6151.6001459904965, 6269.404406581368, 6269.749210031593, 6279.215098112736, 6281.780137695182, 3324.5844269466315, 3624.9275014499694, 3821.866234681787, 6239.407256310666, 6242.875142497147, 6064.0, 6187.381261873777, 6207.348228435994, 6212.565120441571, 6215.782447614311, 5931.614445061057, 6562.77030303937, 6647.734090636369, 6649.5012874034155, 6655.201375834931, 27713.307167320778, 28460.715392846014, 28786.136415907557, 28893.56659650107, 29709.40581188386, 2264.558411109834, 2337.6960995070704, 2339.2748248043163, 2340.695709557747, 2341.040173528845, 17992.10039498033, 18340.26638934441, 19172.520686982938, 19310.517237069045, 19528.31650892226, 2251.79733823955, 2268.773122687718, 2334.708161479815, 2335.497867958397, 2346.483773569829, 153669.0, 156612.0, 168118.0, 170914.0, 173561.13219433822, 17999.73000404995, 22792.0, 23461.0, 23973.561586304877, 24345.26964191077, 32898.67101328956, 40421.556170117234, 40813.38779918304, 40847.79576102101, 41101.0, 8782.868256976151, 10749.247552671395, 10855.837162442569, 10875.673729788119, 11096.778064438666, 8503.532305723245, 8520.914790852135, 8523.275521580736, 8705.303575713928, 8713.869291960626, 10978.176636752116, 11036.282641628268, 11083.833742493869, 11229.606963756229, 11232.887671123184, 4305.0, 4412.0, 4447.510773814878, 4451.755153466591, 4459.308807134899, 773.2615352338503, 948.1798244518442, 952.4523399045577, 990.8464188050864, 995.930284880066, 17921.014344211195, 18200.45398638043, 19379.80620193808, 20928.581428371654, 21195.78804211938, 968.5593055159885, 972.3242346569067, 996.4917891875195, 1003.4180175498193, 1009.3540134314045, 10176.847347289797, 10584.894151058545, 10585.0, 10593.258471906893, 10598.417087060287, 705577.0, 718793.0, 723404.0, 727536.0, 736375.0, 153246.0, 154087.22956385146, 154914.47970361737, 161974.19012905096, 165151.8712032209, 1120.7422292872684, 1150.61454412771, 1177.8998785103363, 1178.1399578307712, 1178.3754610056683, 17991.460256192335, 18079.45761627153, 18095.914245145334, 18108.72836907474, 18348.357807476674, 58067.0, 59348.0, 59787.40212597993, 62291.0, 62508.37491625026, 64418.30352902298, 86807.0, 88606.0, 88890.0, 89582.55208723915, 10966.725831854268, 12396.256224626552, 12605.93697031509, 12704.936475317565, 12832.55086071983, 13560.457581697015, 13576.86423135756, 13808.447662093404, 13929.930350348184, 13948.232847193502, 10389.896101038892, 10708.464576771286, 10929.56281748753, 11575.421228938689, 12102.75794484123, 10711.303765255234, 10827.945860270649, 10892.019718225081, 11229.38238396896, 11239.66281011571, 10798.0, 11082.833757493483, 11168.385738784445, 11222.0, 11307.491162897853, 10023.498825058863, 11114.277571957797, 11324.0, 11779.764404711686, 11873.168878178445, 11397.316161030365, 11509.309441433541, 11659.475323610628, 11684.47419866125, 11772.058235341323], "value": 11550.24789673862, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1327.2368388176799, 1389.5483967710497, 1412.399730114701, 1413.6253892718432, 1415.922124283164, 11281.32312061277, 11771.823422648657, 11782.528698852035, 11788.941055294734, 11799.882001179996, 11253.437328133601, 11665.825012624797, 11764.823527647091, 11768.470418831152, 11786.17496775226, 2355.9764402355972, 2403.9158629447884, 2409.9879500602474, 2411.5418070566534, 2412.8311018228733, 2089.279198676454, 2340.6137987232087, 2442.963355549668, 2443.2792326263793, 2444.8166387521005, 2144.3888491779844, 2396.8442051266697, 2499.6375525548783, 2501.062101711858, 2501.524710305045, 2453.852768833876, 2483.714372847128, 2487.838290511111, 2490.464550121714, 2492.239866840613, 2056.5578400643785, 2445.119756887537, 2455.815813813971, 2456.2631210636737, 2459.717132529764, 11553.960143587034, 11851.407429628483, 11865.110116741278, 11871.88128118725, 11873.643790686294, 6392.3927226913365, 6654.467642588581, 6656.733730650768, 6658.367455091807, 6670.3329667033395, 3908.9413658795143, 4149.875503734893, 4243.915121697549, 4309.870703878889, 4327.740335579875, 1242.2670624331688, 1253.160382543698, 1281.923084614926, 1282.4036822877313, 1294.139397300794, 16638.83361166385, 16674.249658765264, 16714.916425417916, 16720.41478548245, 16728.41450549225, 5361.919571206435, 5403.0, 5599.552035837123, 5647.548196144298, 5713.857153571111, 12407.565735199225, 12411.069169812301, 12425.37873106341, 12438.315892625993, 12452.626421207378, 6526.934730652728, 6527.738890444329, 6533.0, 6536.57512261711, 6543.803685889431, 6072.423119803611, 6096.664683442454, 6107.051860370598, 6161.322254551996, 6172.043333283348, 4249.91500170001, 4341.696081274281, 4360.825566977349, 4395.27477966132, 4409.9559004410185, 1247.7255003899127, 1274.7195616964252, 1279.2580303423993, 1292.6122163350958, 1299.0, 669.4568968937208, 675.9425448836805, 733.1422235983912, 754.2645920227844, 764.6520833020962, 6283.403076707706, 6484.25431075423, 6599.769008084694, 6632.9336706633285, 6774.830629234309, 583.1398686936734, 593.2880543347914, 596.7374355283662, 602.8553147244629, 719.8769918926491, 3687.3178461984617, 4103.199876024206, 4135.255653982312, 4301.634361079344, 4311.353297005474, 14753.48362807318, 15416.537503874903, 15428.768568471482, 15441.382344706086, 15450.690986180438, 14780.778288325684, 14923.701525969636, 15000.62498437526, 15208.923955380153, 15363.692726145639, 10743.409112498888, 10802.567897284021, 10917.01746842772, 10919.12646988239, 10967.287126336763, 6414.583052101599, 6495.740170393131, 6579.374959378852, 6615.140031795836, 6667.566608170453, 12550.30973296441, 13436.731265374834, 13469.932650336686, 13769.105008174436, 13925.860741392862, 11102.722431939266, 13902.0, 13927.23400212998, 14047.628569143537, 14098.647533811736, 8699.130086991503, 8714.30285577165, 8818.382713210014, 8842.778930526789, 8845.823083538164, 10771.569137234736, 10782.24524283324, 10907.83638245411, 10911.945440273066, 10916.836247456453, 9067.954660226656, 9146.268298536233, 9181.311401644769, 9278.443293402417, 9288.767780805534, 8996.190342869173, 9007.594658240527, 9024.729258122266, 9099.408538444979, 9267.582958766738, 7499.400047996256, 8266.751997440086, 8272.0, 8281.337493000667, 8282.544460054754, 5633.0, 5862.355140934579, 5869.501092407022, 6033.245844269466, 6103.565662069322, 5926.348101708722, 5945.137954996588, 6049.3950604939155, 6145.262568491809, 6294.213223347082], "value": 5316.876459868599, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [378.77841462744294, 390.2760379496035, 403.81828177320216, 404.4075429495788, 407.65553107624066, 5820.457578741637, 6011.947909115898, 6116.969415152924, 6133.417325354089, 6135.539834512407, 5834.387389324123, 5871.207387002753, 5937.703114844262, 5990.101484777286, 6021.729022194001, 4611.44662640482, 4613.538646135376, 4617.584417402433, 4618.960733834885, 4621.306803979413, 4014.658754005913, 4486.573775491323, 4572.337011133383, 4596.172688915994, 4648.907021859561, 3959.0402750638473, 4554.0, 4557.544245575449, 4562.931556026662, 4593.402857628504, 4561.452625684906, 4562.178807814592, 4571.38286331346, 4577.5880170784785, 4578.610818080434, 3513.209527856212, 3955.0903292242947, 4064.309067458539, 4073.429719839225, 4098.446709694183, 4849.806007759686, 5882.235349385782, 5896.587238893279, 5926.555508336849, 5929.762809487615, 4544.795484203219, 5443.8094666686475, 5493.835184944418, 5494.560435165177, 5506.559475241971, 4994.751312171957, 6093.969530152365, 6417.1657684500715, 6422.293547709795, 6422.7109780059545, 4417.514073451917, 4660.487346391894, 4661.930071048937, 4674.368960190399, 4682.6019788318035, 6156.415140561639, 6288.779892703734, 6516.5112616553, 6689.397954184098, 6777.559458635223, 4672.0, 4737.526247375235, 4741.051789642085, 4751.121042607059, 4755.429348478205, 4248.874048377183, 4802.471728109905, 4805.255185446262, 4831.541003604652, 4842.418909730784, 5045.66289933168, 5188.558972487305, 5190.377154741455, 5273.604479664041, 5463.836084917459, 6191.876162476815, 6405.423511883952, 6486.664800671754, 6533.738650454024, 6536.411722944958, 1262.722201115753, 1428.557147284345, 1591.5225432370244, 1614.3784642912563, 1619.4170098764434, 975.9703512793928, 1056.144522936424, 1079.2930630437077, 1093.147345070846, 1152.6023521884936, 5761.625494342854, 5954.345022047572, 5985.311689155716, 5994.670293133832, 6030.969845150834, 6475.384838440341, 6561.770338038145, 6625.503087268474, 6626.337366263431, 6635.170603674541, 5212.139996900545, 5891.9705401473575, 6035.094735789667, 6040.546958978094, 6105.961986462312, 3081.553174789643, 3382.661733826598, 3410.2497450560836, 3425.3149370126075, 3427.6572342765526, 5675.318961724537, 6148.938510614926, 6547.541672082908, 6659.567128136752, 6721.764738234237, 6366.936330636727, 6732.326767323327, 6734.966325168441, 6755.763548275787, 6766.864662706718, 6145.508359331243, 6608.471322294205, 6656.567323123982, 6685.431738302202, 6716.83207919806, 5985.6408615483215, 5987.31145918225, 6267.780627678192, 6486.0, 6540.738370465128, 5663.490285874291, 6141.447269745744, 6372.0, 6380.393862583047, 6479.023897711055, 6449.322821103717, 6704.061431399706, 6735.461163106842, 6745.494087943522, 6752.831179220559, 3506.089945345306, 4081.0614957894763, 4513.526079761577, 4606.930896036495, 4623.093486004321, 6534.183227096613, 6534.4772418205475, 6534.863265632618, 6541.574797638138, 6593.538452308292, 6105.358937311518, 6204.177099419663, 6259.749610015549, 6349.9682501587195, 6351.237851457669, 6090.786822461193, 6171.6297022178815, 6258.968705156445, 6259.593126446948, 6287.46556542699, 4975.825846095514, 5268.315119034501, 6154.015247649419, 6176.969115154396, 6216.471599913877, 6036.215292012011, 6213.79989305517, 6342.49260059185, 6352.269489008639, 6369.299377068426, 5184.896302074013, 6227.19046523949, 6232.314445411092, 6237.970734828702, 6267.905981410374], "value": 4734.0724675115025, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [675.4933799650262, 690.9101816763823, 753.8303881626634, 844.8901642786437, 871.65569600008, 15134.016288941224, 15798.289076991534, 15816.288267027983, 15823.20883955802, 15830.208489575518, 14441.205733684643, 15065.171415572138, 15228.0, 15240.466583669573, 15257.237138143104, 925.4401087342162, 952.1383148250844, 956.5934477846922, 957.6696039866235, 959.184693010942, 978.7944531648327, 982.2191357870474, 982.7002764156929, 982.7297493189394, 983.9114479696826, 1033.0495943731785, 1034.105498743589, 1034.1261633919326, 1036.4040676610941, 1036.8392899100613, 1002.8846682631518, 1010.0404615615195, 1013.6958912326272, 1013.8073765984476, 1020.8264595018865, 754.7584772872683, 754.8414832885101, 755.5466719968031, 757.0914902117481, 758.1205801270555, 13783.862161378458, 13954.372053257628, 13960.860391396058, 13985.300734963314, 15096.773548396783, 16331.83668163315, 16574.83425165757, 16890.408835690814, 16926.661466770594, 17088.57278568033, 13337.466501340032, 13554.86445135546, 13597.184168949894, 13713.794293085612, 13720.245386503739, 3391.423458012119, 3421.196018935548, 3421.9144521386916, 3422.469517224834, 3423.4180189367867, 92933.0, 119684.0, 120998.58002839983, 121062.0, 121145.18282225773, 11236.606718764804, 11913.689494155637, 13395.866041339463, 13792.0, 13829.03196776216, 23989.76010239875, 24377.0, 24766.0, 24829.379265518506, 25343.746562534507, 8205.343572514184, 8600.139986001475, 8722.738317850475, 8746.169113934293, 8774.60514276859, 4511.661625378109, 4590.081983603226, 4594.65540084495, 4597.0346227291975, 4597.770111494478, 4162.666986641061, 4177.164567086595, 4299.570042995738, 4301.978490107529, 4308.3968244445805, 909.6952520905571, 930.330162283155, 936.1106948399048, 942.665353799405, 945.579217248318, 585.913131141726, 633.4678869749432, 668.9966550167218, 673.6598018000976, 689.4449967775888, 9659.855102173473, 9952.950235248922, 11281.0, 11587.88412115868, 11631.185816992898, 512.9743512824344, 619.704816932613, 644.365300179323, 654.4894981914115, 680.2890978927034, 5187.559057480081, 5194.298769666122, 5194.948050519522, 5285.947140528622, 5293.920591191135, 97614.51192744133, 101330.0, 102129.0, 103869.0, 105622.4718876416, 81614.0, 88365.0, 89166.0, 89277.66083508753, 90979.54510227406, 52829.530214726285, 70989.2901070993, 71285.0, 75143.62428187823, 76839.0, 10337.586496540054, 11395.74646788836, 12158.513659453523, 12163.513459461523, 12286.262824230575, 29541.55687664644, 36412.81793591015, 36420.81789591035, 36627.0, 37756.0, 47243.52756472391, 47413.288800668706, 47456.28815567838, 47690.0, 47694.13835169901, 15398.15310157952, 15631.531054068397, 15777.68444631078, 15803.288852001457, 15981.760273596137, 16160.191990400197, 17568.824311756718, 17610.20754066096, 17663.470095897144, 17990.730139047664, 14611.85388146105, 16065.839341606434, 16160.515184544482, 16182.514524564282, 16205.027698338137, 15937.840621593636, 16126.516204513884, 16163.919180404022, 16170.191490425666, 16295.022298662117, 15481.612959676098, 15671.529854104396, 15891.0, 15950.282237299582, 16002.119883406524, 11067.612633557786, 11193.0, 11324.150688698215, 11480.425978700865, 11492.0, 11472.73799882029, 11744.412779361168, 12349.567765128537, 12481.251124932533, 12569.86871181598], "value": 8022.327061162145, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1576.3, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [110.0, 122.0, 125.0, 123.0, 124.0, 124.0, 124.0, 123.0, 125.0, 124.0], "value": 122.4, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [188.0, 157.0, 120.0, 161.0, 117.0, 119.0, 120.0, 122.0, 146.0, 120.0], "value": 137.0, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [217.0, 250.0, 296.0, 218.0, 210.0, 217.0, 210.0, 214.0, 209.0, 206.0], "value": 224.7, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 65.0, 61.0, 98.0, 68.0, 69.0, 66.0, 61.0, 83.0, 62.0], "value": 71.8, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 76.0, 95.0, 76.0, 76.0, 73.0, 92.0, 74.0, 75.0, 92.0], "value": 82.1, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 92.0, 93.0, 93.0, 93.0, 92.0, 92.0, 94.0, 92.0], "value": 92.8, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [101.0, 103.0, 101.0, 102.0, 100.0, 102.0, 100.0, 102.0, 102.0, 102.0], "value": 101.5, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [100.0, 101.0, 101.0, 103.0, 101.0, 100.0, 100.0, 98.0, 101.0, 100.0], "value": 100.5, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 51.0, 51.0, 51.0, 52.0, 52.0, 51.0, 52.0, 52.0, 51.0], "value": 51.6, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [60.0, 70.0, 71.0, 69.0, 66.0, 63.0, 65.0, 63.0, 66.0, 65.0], "value": 65.8, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [89.0, 90.0, 92.0, 91.0, 89.0, 91.0, 89.0, 88.0, 90.0, 91.0], "value": 90.0, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [151.0, 151.0, 155.0, 154.0, 148.0, 150.0, 164.0, 150.0, 204.0, 149.0], "value": 157.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [199.0, 207.0, 218.0, 197.0, 197.0, 198.0, 196.0, 199.0, 201.0, 199.0], "value": 201.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [70.0, 73.0, 73.0, 72.0, 72.0, 74.0, 87.0, 105.0, 76.0, 72.0], "value": 77.4, "unit": "score"}]}]} 04:54:33 INFO - Return code: 0 04:54:33 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:54:33 ERROR - # TBPL SUCCESS # 04:54:33 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:54:33 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:54:33 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:54:33 INFO - 2017-04-08 04:54:33.433 screenresolution[1696:14522] starting screenresolution argv=screenresolution get 04:54:33 INFO - 2017-04-08 04:54:33.436 screenresolution[1696:14522] Display 0: 1600x1200x32@60 04:54:33 INFO - 2017-04-08 04:54:33.443 screenresolution[1697:14525] starting screenresolution argv=screenresolution list 04:54:33 INFO - Available Modes on Display 0 04:54:33 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:54:33 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:54:33 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:54:33 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:54:33 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:54:33 INFO - Intel Iris: 04:54:33 INFO - Chipset Model: Intel Iris 04:54:33 INFO - Type: GPU 04:54:33 INFO - Bus: Built-In 04:54:33 INFO - VRAM (Dynamic, Max): 1536 MB 04:54:33 INFO - Vendor: Intel (0x8086) 04:54:33 INFO - Device ID: 0x0a2e 04:54:33 INFO - Revision ID: 0x0009 04:54:33 INFO - Displays: 04:54:33 INFO - Display: 04:54:33 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:54:33 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:54:33 INFO - Display Serial Number: 1600x1200 60 04:54:33 INFO - Main Display: Yes 04:54:33 INFO - Mirror: Off 04:54:33 INFO - Online: Yes 04:54:33 INFO - Rotation: Supported 04:54:33 INFO - Return code: 0 04:54:33 INFO - Running post-action listener: _resource_record_post_action 04:54:33 INFO - [mozharness: 2017-04-08 11:54:33.698400Z] Finished run-tests step (success) 04:54:33 INFO - Running post-run listener: _resource_record_post_run 04:54:33 INFO - Total resource usage - Wall time: 1203s; CPU: 53.0%; Read bytes: 31915008; Write bytes: 517176320; Read time: 198; Write time: 1586 04:54:33 INFO - TinderboxPrint: CPU usage
53.4% 04:54:33 INFO - TinderboxPrint: I/O read bytes / time
31,915,008 / 198 04:54:33 INFO - TinderboxPrint: I/O write bytes / time
517,176,320 / 1,586 04:54:33 INFO - TinderboxPrint: CPU idle
2,244.6 (46.6%) 04:54:33 INFO - TinderboxPrint: CPU system
959.0 (19.9%) 04:54:33 INFO - TinderboxPrint: CPU user
1,610.1 (33.4%) 04:54:33 INFO - TinderboxPrint: Swap in / out
234,930,176 / 0 04:54:33 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207200768; Write bytes: 204521472; Read time: 15974; Write time: 441 04:54:33 INFO - run-tests - Wall time: 1184s; CPU: 53.0%; Read bytes: 29830144; Write bytes: 305576960; Read time: 178; Write time: 1117 04:54:34 INFO - Running post-run listener: _upload_blobber_files 04:54:34 INFO - Blob upload gear active. 04:54:34 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:54:34 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:54:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:54:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:54:34 INFO - (blobuploader) - INFO - Open directory for files ... 04:54:34 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:54:34 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:34 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:35 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:54:35 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:35 INFO - (blobuploader) - INFO - Done attempting. 04:54:35 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:54:35 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:35 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:36 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:54:36 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:36 INFO - (blobuploader) - INFO - Done attempting. 04:54:36 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:54:36 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:36 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:38 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:54:38 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:38 INFO - (blobuploader) - INFO - Done attempting. 04:54:38 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:54:38 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:54:38 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:54:40 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:54:40 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:54:40 INFO - (blobuploader) - INFO - Done attempting. 04:54:40 INFO - (blobuploader) - INFO - Iteration through files over. 04:54:40 INFO - Return code: 0 04:54:40 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:54:40 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:54:40 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88e3a14c943ad544fe431be9168e0867119066bd47db93e630d083c229d76222bbb77a4e76b5e48b4262fe3f7713190826e1199c5150d90f40c7c51ce3c3b371", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/518797f2392b6a588a88eded61c6aac1941f8130628bda468a8a3e0030d5ae25e763c81cf1dd3b983d4142ce3a20ef9064f00745b0bce6fe1938543fe3be89c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3e61b55cd219d8078f35e8f6a9010c10ec1b7e6c308cdf2f737ba377c72d410e81fb078e7002b2d2c821074e51a511b19abf043d87930c78fb60ac802eb8a67", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ceddbcd5e9db9d1555cd054edb794e5c9d113bd214e423b870a81632641c47b55b9c4d3c585101428b40c6733abcaa5ae658dd5a053644c5c7430f34dd48af3"} 04:54:40 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:54:40 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:54:40 INFO - Contents: 04:54:40 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/88e3a14c943ad544fe431be9168e0867119066bd47db93e630d083c229d76222bbb77a4e76b5e48b4262fe3f7713190826e1199c5150d90f40c7c51ce3c3b371", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/518797f2392b6a588a88eded61c6aac1941f8130628bda468a8a3e0030d5ae25e763c81cf1dd3b983d4142ce3a20ef9064f00745b0bce6fe1938543fe3be89c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3e61b55cd219d8078f35e8f6a9010c10ec1b7e6c308cdf2f737ba377c72d410e81fb078e7002b2d2c821074e51a511b19abf043d87930c78fb60ac802eb8a67", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ceddbcd5e9db9d1555cd054edb794e5c9d113bd214e423b870a81632641c47b55b9c4d3c585101428b40c6733abcaa5ae658dd5a053644c5c7430f34dd48af3"} 04:54:40 INFO - Running post-run listener: copy_logs_to_upload_dir 04:54:40 INFO - Copying logs to upload dir... 04:54:40 INFO - mkdir: /builds/slave/test/build/upload/logs 04:54:40 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1299.433780 ========= master_lag: 0.06 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 39 secs) (at 2017-04-08 04:54:40.557747) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-08 04:54:40.562655) ========= 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.mJt7CF34Vv/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.gABp1l7gK4/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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/88e3a14c943ad544fe431be9168e0867119066bd47db93e630d083c229d76222bbb77a4e76b5e48b4262fe3f7713190826e1199c5150d90f40c7c51ce3c3b371", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/518797f2392b6a588a88eded61c6aac1941f8130628bda468a8a3e0030d5ae25e763c81cf1dd3b983d4142ce3a20ef9064f00745b0bce6fe1938543fe3be89c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3e61b55cd219d8078f35e8f6a9010c10ec1b7e6c308cdf2f737ba377c72d410e81fb078e7002b2d2c821074e51a511b19abf043d87930c78fb60ac802eb8a67", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ceddbcd5e9db9d1555cd054edb794e5c9d113bd214e423b870a81632641c47b55b9c4d3c585101428b40c6733abcaa5ae658dd5a053644c5c7430f34dd48af3"} build_url:https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011053 build_url: 'https://queue.taskcluster.net/v1/task/ExvM5Va5Sw28xw6LSai0rw/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/88e3a14c943ad544fe431be9168e0867119066bd47db93e630d083c229d76222bbb77a4e76b5e48b4262fe3f7713190826e1199c5150d90f40c7c51ce3c3b371", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/518797f2392b6a588a88eded61c6aac1941f8130628bda468a8a3e0030d5ae25e763c81cf1dd3b983d4142ce3a20ef9064f00745b0bce6fe1938543fe3be89c8", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/c3e61b55cd219d8078f35e8f6a9010c10ec1b7e6c308cdf2f737ba377c72d410e81fb078e7002b2d2c821074e51a511b19abf043d87930c78fb60ac802eb8a67", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/9ceddbcd5e9db9d1555cd054edb794e5c9d113bd214e423b870a81632641c47b55b9c4d3c585101428b40c6733abcaa5ae658dd5a053644c5c7430f34dd48af3"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-08 04:54:40.604747) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 04:54:40.605088) ========= 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.mJt7CF34Vv/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.gABp1l7gK4/Listeners TMPDIR=/var/folders/_8/27z362bn1ds2qsrfjqy_jf7400000w/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.005128 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-08 04:54:40.654031) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-08 04:54:40.657407) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-08 04:54:40.657748) ========= ========= Total master_lag: 0.21 =========