builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0356 starttime: 1492690522.64 results: success (0) buildid: 20170420030346 builduid: f33f324b2ee049dc9df23bee30d0bcc0 revision: 27311156637f9b5d4504373967e01c4241902ae7 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 05:15:22.639244) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-04-20 05:15:22.639706) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 05:15:22.639994) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-04-20 05:15:22.670317) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 05:15:22.670751) ========= 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.k8ui64L1JJ/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.NrYg77tQQh/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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-20 05:15:22-- 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% 22.3M=0.001s 2017-04-20 05:15:22 (22.3 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.136833 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 05:15:22.834520) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 05:15:22.834947) ========= 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.k8ui64L1JJ/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.NrYg77tQQh/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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.026894 ========= master_lag: 0.02 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 05:15:22.885658) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-20 05:15:22.889204) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 27311156637f9b5d4504373967e01c4241902ae7 --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 27311156637f9b5d4504373967e01c4241902ae7 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.k8ui64L1JJ/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.NrYg77tQQh/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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-20 05:15:22,998 truncating revision to first 12 chars 2017-04-20 05:15:22,998 Setting DEBUG logging. 2017-04-20 05:15:22,998 attempt 1/10 2017-04-20 05:15:22,998 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/27311156637f?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-04-20 05:15:24,023 unpacking tar archive at: mozilla-central-27311156637f/testing/mozharness/ program finished with exit code 0 elapsedTime=1.310050 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-04-20 05:15:24.224084) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 05:15:24.224490) ========= script_repo_revision: 27311156637f9b5d4504373967e01c4241902ae7 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-04-20 05:15:24.224923) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 05:15:24.225201) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-04-20 05:15:24.246342) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-20 05:15:24.246745) ========= /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.k8ui64L1JJ/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.NrYg77tQQh/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 05:15:24 INFO - MultiFileLogger online at 20170420 05:15:24 in /builds/slave/test 05:15:24 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 05:15:24 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 05:15:24 INFO - {'append_to_log': False, 05:15:24 INFO - 'base_work_dir': '/builds/slave/test', 05:15:24 INFO - 'blob_upload_branch': 'Firefox', 05:15:24 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 05:15:24 INFO - 'branch': 'Firefox', 05:15:24 INFO - 'buildbot_json_path': 'buildprops.json', 05:15:24 INFO - 'config_files': ('talos/mac_config.py',), 05:15:24 INFO - 'default_actions': ('clobber', 05:15:24 INFO - 'read-buildbot-config', 05:15:24 INFO - 'download-and-extract', 05:15:24 INFO - 'populate-webroot', 05:15:24 INFO - 'create-virtualenv', 05:15:24 INFO - 'install', 05:15:24 INFO - 'run-tests'), 05:15:24 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 05:15:24 INFO - 'download_minidump_stackwalk': True, 05:15:24 INFO - 'download_symbols': 'ondemand', 05:15:24 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 05:15:24 INFO - 'tooltool.py': '/tools/tooltool.py', 05:15:24 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 05:15:24 INFO - '/tools/misc-python/virtualenv.py')}, 05:15:24 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 05:15:24 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 05:15:24 INFO - 'gecko_profile': False, 05:15:24 INFO - 'gecko_profile_interval': 0, 05:15:24 INFO - 'installer_path': 'installer.exe', 05:15:24 INFO - 'log_level': 'info', 05:15:24 INFO - 'log_name': 'talos', 05:15:24 INFO - 'log_to_console': True, 05:15:24 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 05:15:24 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 05:15:24 INFO - 'opt_config_files': (), 05:15:24 INFO - 'pip_index': False, 05:15:24 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:15:24 INFO - 'cmd': ('bash', 05:15:24 INFO - '-c', 05:15:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:15:24 INFO - 'enabled': True, 05:15:24 INFO - 'halt_on_failure': False, 05:15:24 INFO - 'name': 'check_screen_resolution'},), 05:15:24 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 05:15:24 INFO - 'cmd': ('bash', 05:15:24 INFO - '-c', 05:15:24 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 05:15:24 INFO - 'enabled': True, 05:15:24 INFO - 'halt_on_failure': False, 05:15:24 INFO - 'name': 'check_screen_resolution'},), 05:15:24 INFO - 'run_cmd_checks_enabled': True, 05:15:24 INFO - 'suite': 'dromaeojs', 05:15:24 INFO - 'system_bits': '32', 05:15:24 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 05:15:24 INFO - 'title': 't-yosemite-r7-0356', 05:15:24 INFO - 'tooltool_cache': '/builds/tooltool_cache', 05:15:24 INFO - 'use_talos_json': True, 05:15:24 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 05:15:24 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 05:15:24 INFO - 'work_dir': 'build'} 05:15:24 INFO - [mozharness: 2017-04-20 12:15:24.463025Z] Running clobber step. 05:15:24 INFO - Running pre-action listener: _resource_record_pre_action 05:15:24 INFO - Running main action method: clobber 05:15:24 INFO - rmtree: /builds/slave/test/build 05:15:24 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 05:15:26 INFO - Running post-action listener: _resource_record_post_action 05:15:26 INFO - [mozharness: 2017-04-20 12:15:26.976200Z] Finished clobber step (success) 05:15:26 INFO - [mozharness: 2017-04-20 12:15:26.976421Z] Running read-buildbot-config step. 05:15:26 INFO - Running pre-action listener: _resource_record_pre_action 05:15:26 INFO - Running main action method: read_buildbot_config 05:15:26 INFO - Using buildbot properties: 05:15:26 INFO - { 05:15:26 INFO - "project": "", 05:15:26 INFO - "product": "firefox", 05:15:26 INFO - "script_repo_revision": "production", 05:15:26 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 05:15:26 INFO - "repository": "", 05:15:26 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 05:15:26 INFO - "buildid": "20170420030346", 05:15:26 INFO - "stage_platform": "macosx64", 05:15:26 INFO - "basedir": "/builds/slave/test", 05:15:26 INFO - "nightly_build": "True", 05:15:26 INFO - "buildnumber": 17, 05:15:26 INFO - "slavename": "t-yosemite-r7-0356", 05:15:26 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 05:15:26 INFO - "platform": "yosemite_r7", 05:15:26 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 05:15:26 INFO - "branch": "mozilla-central", 05:15:26 INFO - "repo_path": "mozilla-central", 05:15:26 INFO - "revision": "27311156637f9b5d4504373967e01c4241902ae7", 05:15:26 INFO - "pgo_build": "False", 05:15:26 INFO - "builduid": "f33f324b2ee049dc9df23bee30d0bcc0", 05:15:26 INFO - "slavebuilddir": "test" 05:15:26 INFO - } 05:15:26 INFO - Found installer url https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 05:15:26 INFO - Running post-action listener: _resource_record_post_action 05:15:26 INFO - [mozharness: 2017-04-20 12:15:26.982349Z] Finished read-buildbot-config step (success) 05:15:26 INFO - [mozharness: 2017-04-20 12:15:26.982548Z] Running download-and-extract step. 05:15:26 INFO - Running pre-action listener: _resource_record_pre_action 05:15:26 INFO - Running main action method: download_and_extract 05:15:26 INFO - mkdir: /builds/slave/test/build/tests 05:15:26 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:15:26 INFO - trying https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 05:15:26 INFO - Downloading https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:15:26 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 05:15:28 INFO - Downloaded 1325 bytes. 05:15:28 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 05:15:28 INFO - Using the following test package requirements: 05:15:28 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:15:28 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 05:15:28 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:15:28 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:15:28 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 05:15:28 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:15:28 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 05:15:28 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:15:28 INFO - u'jsshell-mac.zip'], 05:15:28 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:15:28 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 05:15:28 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 05:15:28 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:15:28 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 05:15:28 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:15:28 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 05:15:28 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:15:28 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 05:15:28 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 05:15:28 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 05:15:28 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 05:15:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:15:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:15:28 INFO - Fetch https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:15:29 INFO - Expected file size: 52525041 05:15:29 INFO - Obtained file size: 52525041 05:15:46 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 05:15:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 05:15:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 05:15:46 INFO - Fetch https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 05:15:48 INFO - Expected file size: 52525041 05:15:48 INFO - Obtained file size: 52525041 05:16:03 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 05:16:03 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 05:16:03 INFO - Fetch https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 05:16:04 INFO - Expected file size: 14408811 05:16:04 INFO - Obtained file size: 14408811 05:16:05 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:05 INFO - trying https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:16:05 INFO - Downloading https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 05:16:05 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 05:16:07 INFO - Downloaded 71063554 bytes. 05:16:07 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:16:07 INFO - mkdir: /builds/slave/test/properties 05:16:07 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 05:16:07 INFO - Writing to file /builds/slave/test/properties/build_url 05:16:07 INFO - Contents: 05:16:07 INFO - build_url:https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 05:16:07 INFO - Running post-action listener: _resource_record_post_action 05:16:07 INFO - Running post-action listener: set_extra_try_arguments 05:16:07 INFO - [mozharness: 2017-04-20 12:16:07.812460Z] Finished download-and-extract step (success) 05:16:07 INFO - [mozharness: 2017-04-20 12:16:07.812609Z] Running populate-webroot step. 05:16:07 INFO - Running pre-action listener: _resource_record_pre_action 05:16:07 INFO - Running main action method: populate_webroot 05:16:07 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 05:16:07 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 05:16:07 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 05:16:07 INFO - '--tppagecycles', 05:16:07 INFO - '7'], 05:16:07 INFO - 'tests': ['tsvgm']}}, 05:16:07 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['tresize', 'tcanvasmark']}, 05:16:07 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 05:16:07 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['dromaeo_css', 'kraken']}, 05:16:07 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 05:16:07 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 05:16:07 INFO - 'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:07 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 05:16:07 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 05:16:07 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 05:16:07 INFO - 'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['damp', 'tps']}, 05:16:07 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 05:16:07 INFO - 'tests': ['damp', 'tps']}, 05:16:07 INFO - 'g3': {'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['dromaeo_dom']}, 05:16:07 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 05:16:07 INFO - 'g4': {'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 05:16:07 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 05:16:07 INFO - 'other': {'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['a11yr', 05:16:07 INFO - 'ts_paint', 05:16:07 INFO - 'tpaint', 05:16:07 INFO - 'sessionrestore', 05:16:07 INFO - 'sessionrestore_no_auto_restore', 05:16:07 INFO - 'tabpaint']}, 05:16:07 INFO - 'other-e10s': {'tests': ['a11yr', 05:16:07 INFO - 'ts_paint', 05:16:07 INFO - 'tpaint', 05:16:07 INFO - 'sessionrestore', 05:16:07 INFO - 'sessionrestore_no_auto_restore', 05:16:07 INFO - 'tabpaint']}, 05:16:07 INFO - 'other-e10s_l64': {'tests': ['a11yr', 05:16:07 INFO - 'ts_paint', 05:16:07 INFO - 'tpaint', 05:16:07 INFO - 'sessionrestore', 05:16:07 INFO - 'sessionrestore_no_auto_restore', 05:16:07 INFO - 'tabpaint']}, 05:16:07 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 05:16:07 INFO - 'ts_paint', 05:16:07 INFO - 'tpaint', 05:16:07 INFO - 'sessionrestore', 05:16:07 INFO - 'sessionrestore_no_auto_restore', 05:16:07 INFO - 'tabpaint']}, 05:16:07 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['a11yr', 05:16:07 INFO - 'ts_paint', 05:16:07 INFO - 'tpaint', 05:16:07 INFO - 'sessionrestore', 05:16:07 INFO - 'sessionrestore_no_auto_restore', 05:16:07 INFO - 'tabpaint']}, 05:16:07 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['a11yr', 05:16:07 INFO - 'ts_paint', 05:16:07 INFO - 'tpaint', 05:16:07 INFO - 'sessionrestore', 05:16:07 INFO - 'sessionrestore_no_auto_restore', 05:16:07 INFO - 'tabpaint']}, 05:16:07 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 05:16:07 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 05:16:07 INFO - 'bloom_basic_ref']}, 05:16:07 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['tsvgx', 05:16:07 INFO - 'tsvgr_opacity', 05:16:07 INFO - 'tart', 05:16:07 INFO - 'tscrollx', 05:16:07 INFO - 'cart', 05:16:07 INFO - 'tsvg_static']}, 05:16:07 INFO - 'svgr-e10s': {'tests': ['tsvgx', 05:16:07 INFO - 'tsvgr_opacity', 05:16:07 INFO - 'tart', 05:16:07 INFO - 'tscrollx', 05:16:07 INFO - 'cart', 05:16:07 INFO - 'tsvg_static']}, 05:16:07 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 05:16:07 INFO - 'talos_options': ['--disable-e10s'], 05:16:07 INFO - 'tests': ['tp5o']}, 05:16:07 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 05:16:07 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 05:16:07 INFO - 'talos_options': ['--disable-e10s', 05:16:07 INFO - '--xperf_path', 05:16:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:07 INFO - 'tests': ['tp5n']}, 05:16:07 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 05:16:07 INFO - 'talos_options': ['--xperf_path', 05:16:07 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 05:16:07 INFO - 'tests': ['tp5n']}}, 05:16:07 INFO - 'talos.zip': {'path': '', 05:16:07 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 05:16:07 INFO - Running post-action listener: _resource_record_post_action 05:16:07 INFO - [mozharness: 2017-04-20 12:16:07.831886Z] Finished populate-webroot step (success) 05:16:07 INFO - [mozharness: 2017-04-20 12:16:07.831996Z] Running create-virtualenv step. 05:16:07 INFO - Running pre-action listener: _resource_record_pre_action 05:16:07 INFO - Running main action method: create_virtualenv 05:16:07 INFO - Creating virtualenv /builds/slave/test/build/venv 05:16:07 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 05:16:07 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 05:16:07 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 05:16:07 INFO - Using real prefix '/tools/python27' 05:16:07 INFO - New python executable in /builds/slave/test/build/venv/bin/python 05:16:08 INFO - Installing distribute.............................................................................................................................................................................................done. 05:16:11 INFO - Installing pip.................done. 05:16:11 INFO - Return code: 0 05:16:11 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 05:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 05:16:11 INFO - Reading from file tmpfile_stdout 05:16:11 INFO - Output received: 05:16:11 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 05:16:11 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 05:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:11 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:11 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:11 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:11 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:11 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:11 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 0x1062f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff74055ab80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060d1d30>, '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 0x105ff7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060c6be8>, '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.k8ui64L1JJ/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.NrYg77tQQh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 05:16:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 05:16:11 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8ui64L1JJ/Render', 05:16:11 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:11 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:11 INFO - 'HOME': '/Users/cltbld', 05:16:11 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:11 INFO - 'LOGNAME': 'cltbld', 05:16:11 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:11 INFO - 'MOZ_NO_REMOTE': '1', 05:16:11 INFO - 'NO_EM_RESTART': '1', 05:16:11 INFO - 'PAGER': '/bin/cat', 05:16:11 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:11 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:11 INFO - 'PWD': '/builds/slave/test', 05:16:11 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:11 INFO - 'SHELL': '/bin/bash', 05:16:11 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NrYg77tQQh/Listeners', 05:16:11 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:16:11 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:11 INFO - 'USER': 'cltbld', 05:16:11 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:11 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:11 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:11 INFO - 'XPC_FLAGS': '0x0', 05:16:11 INFO - 'XPC_SERVICE_NAME': '0', 05:16:11 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:12 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 05:16:12 INFO - Cleaning up... 05:16:12 INFO - Return code: 0 05:16:12 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 05:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:12 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:12 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:12 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:12 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:12 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:12 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x1062f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff74055ab80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060d1d30>, '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 0x105ff7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060c6be8>, '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.k8ui64L1JJ/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.NrYg77tQQh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 05:16:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 05:16:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8ui64L1JJ/Render', 05:16:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:12 INFO - 'HOME': '/Users/cltbld', 05:16:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:12 INFO - 'LOGNAME': 'cltbld', 05:16:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:12 INFO - 'MOZ_NO_REMOTE': '1', 05:16:12 INFO - 'NO_EM_RESTART': '1', 05:16:12 INFO - 'PAGER': '/bin/cat', 05:16:12 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:12 INFO - 'PWD': '/builds/slave/test', 05:16:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:12 INFO - 'SHELL': '/bin/bash', 05:16:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NrYg77tQQh/Listeners', 05:16:12 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:16:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:12 INFO - 'USER': 'cltbld', 05:16:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:12 INFO - 'XPC_FLAGS': '0x0', 05:16:12 INFO - 'XPC_SERVICE_NAME': '0', 05:16:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:12 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:12 INFO - Downloading/unpacking psutil>=3.1.1 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:15 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 05:16:15 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:15 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:15 INFO - Installing collected packages: psutil 05:16:15 INFO - Running setup.py install for psutil 05:16:15 INFO - building 'psutil._psutil_osx' extension 05:16:15 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 05:16:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 05:16:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 05:16:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 05:16:16 INFO - building 'psutil._psutil_posix' extension 05:16:16 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 05:16:16 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 05:16:16 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 05:16:16 INFO - ^ 05:16:16 INFO - 1 warning generated. 05:16:16 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 05:16:16 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 05:16:16 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 05:16:16 INFO - Successfully installed psutil 05:16:16 INFO - Cleaning up... 05:16:16 INFO - Return code: 0 05:16:16 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 05:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:16 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:16 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:16 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:16 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:16 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:16 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 0x1062f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff74055ab80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060d1d30>, '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 0x105ff7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060c6be8>, '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.k8ui64L1JJ/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.NrYg77tQQh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:16 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 05:16:16 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 05:16:16 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8ui64L1JJ/Render', 05:16:16 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:16 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:16 INFO - 'HOME': '/Users/cltbld', 05:16:16 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:16 INFO - 'LOGNAME': 'cltbld', 05:16:16 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:16 INFO - 'MOZ_NO_REMOTE': '1', 05:16:16 INFO - 'NO_EM_RESTART': '1', 05:16:16 INFO - 'PAGER': '/bin/cat', 05:16:16 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:16 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:16 INFO - 'PWD': '/builds/slave/test', 05:16:16 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:16 INFO - 'SHELL': '/bin/bash', 05:16:16 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NrYg77tQQh/Listeners', 05:16:16 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:16:16 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:16 INFO - 'USER': 'cltbld', 05:16:16 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:16 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:16 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:16 INFO - 'XPC_FLAGS': '0x0', 05:16:16 INFO - 'XPC_SERVICE_NAME': '0', 05:16:16 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:17 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:17 INFO - Downloading/unpacking mozsystemmonitor==0.3 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:19 INFO - Downloading mozsystemmonitor-0.3.tar.gz 05:16:19 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 05:16:19 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 05:16:19 INFO - Installing collected packages: mozsystemmonitor 05:16:19 INFO - Running setup.py install for mozsystemmonitor 05:16:20 INFO - Successfully installed mozsystemmonitor 05:16:20 INFO - Cleaning up... 05:16:20 INFO - Return code: 0 05:16:20 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 05:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:20 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:20 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:20 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:20 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:20 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 0x1062f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff74055ab80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060d1d30>, '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 0x105ff7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060c6be8>, '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.k8ui64L1JJ/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.NrYg77tQQh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 05:16:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 05:16:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8ui64L1JJ/Render', 05:16:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:20 INFO - 'HOME': '/Users/cltbld', 05:16:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:20 INFO - 'LOGNAME': 'cltbld', 05:16:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:20 INFO - 'MOZ_NO_REMOTE': '1', 05:16:20 INFO - 'NO_EM_RESTART': '1', 05:16:20 INFO - 'PAGER': '/bin/cat', 05:16:20 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:20 INFO - 'PWD': '/builds/slave/test', 05:16:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:20 INFO - 'SHELL': '/bin/bash', 05:16:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NrYg77tQQh/Listeners', 05:16:20 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:16:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:20 INFO - 'USER': 'cltbld', 05:16:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:20 INFO - 'XPC_FLAGS': '0x0', 05:16:20 INFO - 'XPC_SERVICE_NAME': '0', 05:16:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:20 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:20 INFO - Downloading/unpacking jsonschema==2.5.1 05:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:20 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:20 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:20 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:20 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:23 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 05:16:23 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 05:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:23 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:23 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:23 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:23 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:24 INFO - Downloading functools32-3.2.3-2.tar.gz 05:16:24 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 05:16:24 INFO - warning: no files found matching '*.txt' 05:16:24 INFO - no previously-included directories found matching 'build' 05:16:24 INFO - no previously-included directories found matching 'dist' 05:16:24 INFO - no previously-included directories found matching '.git*' 05:16:24 INFO - Installing collected packages: jsonschema, functools32 05:16:24 INFO - Running setup.py install for functools32 05:16:24 INFO - warning: no files found matching '*.txt' 05:16:24 INFO - no previously-included directories found matching 'build' 05:16:24 INFO - no previously-included directories found matching 'dist' 05:16:24 INFO - no previously-included directories found matching '.git*' 05:16:24 INFO - Successfully installed jsonschema functools32 05:16:24 INFO - Cleaning up... 05:16:24 INFO - Return code: 0 05:16:24 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 05:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:24 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 0x1062f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff74055ab80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060d1d30>, '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 0x105ff7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060c6be8>, '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.k8ui64L1JJ/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.NrYg77tQQh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 05:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 05:16:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8ui64L1JJ/Render', 05:16:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:24 INFO - 'HOME': '/Users/cltbld', 05:16:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:24 INFO - 'LOGNAME': 'cltbld', 05:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:24 INFO - 'MOZ_NO_REMOTE': '1', 05:16:24 INFO - 'NO_EM_RESTART': '1', 05:16:24 INFO - 'PAGER': '/bin/cat', 05:16:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:24 INFO - 'PWD': '/builds/slave/test', 05:16:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:24 INFO - 'SHELL': '/bin/bash', 05:16:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NrYg77tQQh/Listeners', 05:16:24 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:16:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:24 INFO - 'USER': 'cltbld', 05:16:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:24 INFO - 'XPC_FLAGS': '0x0', 05:16:24 INFO - 'XPC_SERVICE_NAME': '0', 05:16:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:24 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:24 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 05:16:24 INFO - Cleaning up... 05:16:24 INFO - Return code: 0 05:16:24 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 05:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:24 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:24 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:24 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:24 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:24 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:24 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 0x1062f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff74055ab80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060d1d30>, '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 0x105ff7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060c6be8>, '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.k8ui64L1JJ/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.NrYg77tQQh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:24 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 05:16:24 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 05:16:24 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8ui64L1JJ/Render', 05:16:24 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:24 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:24 INFO - 'HOME': '/Users/cltbld', 05:16:24 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:24 INFO - 'LOGNAME': 'cltbld', 05:16:24 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:24 INFO - 'MOZ_NO_REMOTE': '1', 05:16:24 INFO - 'NO_EM_RESTART': '1', 05:16:24 INFO - 'PAGER': '/bin/cat', 05:16:24 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:24 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:24 INFO - 'PWD': '/builds/slave/test', 05:16:24 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:24 INFO - 'SHELL': '/bin/bash', 05:16:24 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NrYg77tQQh/Listeners', 05:16:24 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:16:24 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:24 INFO - 'USER': 'cltbld', 05:16:24 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:24 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:24 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:24 INFO - 'XPC_FLAGS': '0x0', 05:16:24 INFO - 'XPC_SERVICE_NAME': '0', 05:16:24 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:25 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:25 INFO - Downloading/unpacking blobuploader==1.2.4 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16: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 05:16:27 INFO - Downloading blobuploader-1.2.4.tar.gz 05:16:27 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 05:16:27 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 05:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:27 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:27 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:27 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:27 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:28 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 05:16:28 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 05:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:28 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:28 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:28 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:28 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:29 INFO - Downloading docopt-0.6.1.tar.gz 05:16:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 05:16:29 INFO - Installing collected packages: blobuploader, requests, docopt 05:16:29 INFO - Running setup.py install for blobuploader 05:16:29 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 05:16:29 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 05:16:29 INFO - Running setup.py install for requests 05:16:29 INFO - Running setup.py install for docopt 05:16:29 INFO - Successfully installed blobuploader requests docopt 05:16:29 INFO - Cleaning up... 05:16:29 INFO - Return code: 0 05:16:29 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16: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')]} 05:16:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16: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')]} 05:16:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:29 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 0x1062f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff74055ab80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060d1d30>, '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 0x105ff7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060c6be8>, '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.k8ui64L1JJ/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.NrYg77tQQh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:16:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:16:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8ui64L1JJ/Render', 05:16:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:29 INFO - 'HOME': '/Users/cltbld', 05:16:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:29 INFO - 'LOGNAME': 'cltbld', 05:16:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:29 INFO - 'MOZ_NO_REMOTE': '1', 05:16:29 INFO - 'NO_EM_RESTART': '1', 05:16:29 INFO - 'PAGER': '/bin/cat', 05:16:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:29 INFO - 'PWD': '/builds/slave/test', 05:16:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:29 INFO - 'SHELL': '/bin/bash', 05:16:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NrYg77tQQh/Listeners', 05:16:29 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:16:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:29 INFO - 'USER': 'cltbld', 05:16:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:29 INFO - 'XPC_FLAGS': '0x0', 05:16:29 INFO - 'XPC_SERVICE_NAME': '0', 05:16:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:30 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-NtAjrM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:30 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-txgzKT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:30 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-9rnT54-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:30 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-t4NN0B-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:30 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-IxJ6z6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:30 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-FSN5IK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:30 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-F5nj_U-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:30 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:30 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-DHUR8z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:31 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-0wJrxM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:31 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-QRhbS6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:31 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-0MGJKH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:31 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-xf3Z6H-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:31 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-2SK9BC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:31 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-xBS3Ls-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:31 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-o59f68-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:31 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-kygkCG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:31 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:31 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-APLFsV-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:31 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 05:16:31 INFO - Running setup.py install for manifestparser 05:16:32 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 05:16:32 INFO - Running setup.py install for mozcrash 05:16:32 INFO - Running setup.py install for mozdebug 05:16:32 INFO - Running setup.py install for mozdevice 05:16:32 INFO - Installing dm script to /builds/slave/test/build/venv/bin 05:16:32 INFO - Running setup.py install for mozfile 05:16:32 INFO - Running setup.py install for mozhttpd 05:16:32 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 05:16:32 INFO - Running setup.py install for mozinfo 05:16:32 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 05:16:32 INFO - Running setup.py install for mozInstall 05:16:33 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 05:16:33 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 05:16:33 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 05:16:33 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 05:16:33 INFO - Running setup.py install for mozleak 05:16:33 INFO - Running setup.py install for mozlog 05:16:33 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 05:16:33 INFO - Running setup.py install for moznetwork 05:16:33 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 05:16:33 INFO - Running setup.py install for mozprocess 05:16:33 INFO - Running setup.py install for mozprofile 05:16:33 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 05:16:33 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 05:16:33 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 05:16:33 INFO - Running setup.py install for mozrunner 05:16:34 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 05:16:34 INFO - Running setup.py install for mozscreenshot 05:16:34 INFO - Running setup.py install for moztest 05:16:34 INFO - Running setup.py install for mozversion 05:16:34 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 05:16:34 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 05:16:34 INFO - Cleaning up... 05:16:34 INFO - Return code: 0 05:16:34 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:34 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:34 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:34 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:34 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:34 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:34 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 0x1062f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff74055ab80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060d1d30>, '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 0x105ff7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060c6be8>, '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.k8ui64L1JJ/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.NrYg77tQQh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:34 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 05:16:34 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:16:34 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8ui64L1JJ/Render', 05:16:34 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:34 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:34 INFO - 'HOME': '/Users/cltbld', 05:16:34 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:34 INFO - 'LOGNAME': 'cltbld', 05:16:34 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:34 INFO - 'MOZ_NO_REMOTE': '1', 05:16:34 INFO - 'NO_EM_RESTART': '1', 05:16:34 INFO - 'PAGER': '/bin/cat', 05:16:34 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:34 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:34 INFO - 'PWD': '/builds/slave/test', 05:16:34 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:34 INFO - 'SHELL': '/bin/bash', 05:16:34 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NrYg77tQQh/Listeners', 05:16:34 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:16:34 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:34 INFO - 'USER': 'cltbld', 05:16:34 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:34 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:34 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:34 INFO - 'XPC_FLAGS': '0x0', 05:16:34 INFO - 'XPC_SERVICE_NAME': '0', 05:16:34 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 05:16:34 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-rQwo57-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 05:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 05:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 05:16:34 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-jW54uI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 05:16:34 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:16:34 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 05:16:34 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-OjY59t-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 05:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 05:16:35 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-wbyzI6-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 05:16:35 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)) 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 05:16:35 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-8X8MYb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 05:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 05:16:35 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-dnRCIy-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 05:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 05:16:35 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-SOsFW5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 05:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 05:16:35 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-vseEjQ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 05:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 05:16:35 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-husf8X-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 05:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 05:16:35 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-tSsn82-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 05:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 05:16:35 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-XuSA6f-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 05:16:35 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 05:16:35 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 05:16:35 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-lYpDpn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 05:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 05:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 05:16:36 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-ZVQVcX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 05:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 05:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 05:16:36 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-oxLbav-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 05:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 05:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:36 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-eht11R-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 05:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 05:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 05:16:36 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-q0K1kg-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 05:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 05:16:36 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 05:16:36 INFO - Running setup.py (path:/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/pip-RIz23Q-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 05:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 05:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 05:16:36 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 05:16:36 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)) 05:16:36 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)) 05:16:36 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 05:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:36 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:36 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 05:16:36 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 05:16:36 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 05:16:39 INFO - Downloading blessings-1.6.tar.gz 05:16:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 05:16:39 INFO - Installing collected packages: blessings 05:16:39 INFO - Running setup.py install for blessings 05:16:39 INFO - Successfully installed blessings 05:16:39 INFO - Cleaning up... 05:16:39 INFO - Return code: 0 05:16:39 INFO - Done creating virtualenv /builds/slave/test/build/venv. 05:16:39 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:39 INFO - Reading from file tmpfile_stdout 05:16:39 INFO - Current package versions: 05:16:39 INFO - blessings == 1.6 05:16:39 INFO - blobuploader == 1.2.4 05:16:39 INFO - docopt == 0.6.1 05:16:39 INFO - functools32 == 3.2.3-2 05:16:39 INFO - jsonschema == 2.5.1 05:16:39 INFO - manifestparser == 1.1 05:16:39 INFO - mozInstall == 1.12 05:16:39 INFO - mozcrash == 1.0 05:16:39 INFO - mozdebug == 0.1 05:16:39 INFO - mozdevice == 0.50 05:16:39 INFO - mozfile == 1.2 05:16:39 INFO - mozhttpd == 0.7 05:16:39 INFO - mozinfo == 0.9 05:16:39 INFO - mozleak == 0.1 05:16:39 INFO - mozlog == 3.4 05:16:39 INFO - moznetwork == 0.27 05:16:39 INFO - mozprocess == 0.25 05:16:39 INFO - mozprofile == 0.28 05:16:39 INFO - mozrunner == 6.13 05:16:39 INFO - mozscreenshot == 0.1 05:16:39 INFO - mozsystemmonitor == 0.3 05:16:39 INFO - moztest == 0.8 05:16:39 INFO - mozversion == 1.4 05:16:39 INFO - psutil == 3.1.1 05:16:39 INFO - requests == 1.2.3 05:16:39 INFO - wsgiref == 0.1.2 05:16:39 INFO - Installing None into virtualenv /builds/slave/test/build/venv 05:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:39 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:39 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:39 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:39 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:39 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:39 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 0x1062f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff74055ab80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060d1d30>, '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 0x105ff7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060c6be8>, '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.k8ui64L1JJ/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.NrYg77tQQh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:39 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 05:16:39 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 05:16:39 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8ui64L1JJ/Render', 05:16:39 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:39 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:39 INFO - 'HOME': '/Users/cltbld', 05:16:39 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:39 INFO - 'LOGNAME': 'cltbld', 05:16:39 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:39 INFO - 'MOZ_NO_REMOTE': '1', 05:16:39 INFO - 'NO_EM_RESTART': '1', 05:16:39 INFO - 'PAGER': '/bin/cat', 05:16:39 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:39 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:39 INFO - 'PWD': '/builds/slave/test', 05:16:39 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:39 INFO - 'SHELL': '/bin/bash', 05:16:39 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NrYg77tQQh/Listeners', 05:16:39 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:16:39 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:39 INFO - 'USER': 'cltbld', 05:16:39 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:39 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:39 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:39 INFO - 'XPC_FLAGS': '0x0', 05:16:39 INFO - 'XPC_SERVICE_NAME': '0', 05:16:39 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 05:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 05:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 05:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 05:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 05:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 05:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 05:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 05:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 05:16:40 INFO - Cleaning up... 05:16:40 INFO - Return code: 0 05:16:40 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 05:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 05:16:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:16:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 05:16:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 05:16:40 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 0x1062f3b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1062f6768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7ff74055ab80>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x1060d1d30>, '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 0x105ff7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060c6be8>, '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.k8ui64L1JJ/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.NrYg77tQQh/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 05:16:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 05:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 05:16:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8ui64L1JJ/Render', 05:16:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:16:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:16:40 INFO - 'HOME': '/Users/cltbld', 05:16:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:16:40 INFO - 'LOGNAME': 'cltbld', 05:16:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:16:40 INFO - 'MOZ_NO_REMOTE': '1', 05:16:40 INFO - 'NO_EM_RESTART': '1', 05:16:40 INFO - 'PAGER': '/bin/cat', 05:16:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:16:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:16:40 INFO - 'PWD': '/builds/slave/test', 05:16:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:16:40 INFO - 'SHELL': '/bin/bash', 05:16:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NrYg77tQQh/Listeners', 05:16:40 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:16:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:16:40 INFO - 'USER': 'cltbld', 05:16:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:16:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:16:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:16:40 INFO - 'XPC_FLAGS': '0x0', 05:16:40 INFO - 'XPC_SERVICE_NAME': '0', 05:16:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:16:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 05:16:40 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 05:16:40 INFO - Cleaning up... 05:16:40 INFO - Return code: 0 05:16:40 INFO - Running post-action listener: _resource_record_post_action 05:16:40 INFO - Running post-action listener: _start_resource_monitoring 05:16:40 INFO - Starting resource monitoring. 05:16:40 INFO - [mozharness: 2017-04-20 12:16:40.493813Z] Finished create-virtualenv step (success) 05:16:40 INFO - [mozharness: 2017-04-20 12:16:40.494767Z] Running install step. 05:16:40 INFO - Running pre-action listener: _resource_record_pre_action 05:16:40 INFO - Running main action method: install 05:16:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 05:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 05:16:40 INFO - Reading from file tmpfile_stdout 05:16:40 INFO - Detecting whether we're running mozinstall >=1.0... 05:16:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 05:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 05:16:40 INFO - Reading from file tmpfile_stdout 05:16:40 INFO - Output received: 05:16:40 INFO - Usage: mozinstall [options] installer 05:16:40 INFO - Options: 05:16:40 INFO - -h, --help show this help message and exit 05:16:40 INFO - -d DEST, --destination=DEST 05:16:40 INFO - Directory to install application into. [default: 05:16:40 INFO - "/builds/slave/test"] 05:16:40 INFO - --app=APP Application being installed. [default: firefox] 05:16:40 INFO - mkdir: /builds/slave/test/build/application 05:16:40 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 05:16:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 05:17:00 INFO - Reading from file tmpfile_stdout 05:17:00 INFO - Output received: 05:17:00 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 05:17:00 INFO - Running post-action listener: _resource_record_post_action 05:17:00 INFO - [mozharness: 2017-04-20 12:17:00.230448Z] Finished install step (success) 05:17:00 INFO - [mozharness: 2017-04-20 12:17:00.230624Z] Running run-tests step. 05:17:00 INFO - Running pre-action listener: _resource_record_pre_action 05:17:00 INFO - Running main action method: run_tests 05:17:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:17:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:17:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:17:00 INFO - 2017-04-20 05:17:00.245 screenresolution[1621:7336] starting screenresolution argv=screenresolution get 05:17:00 INFO - 2017-04-20 05:17:00.247 screenresolution[1621:7336] Display 0: 1600x1200x32@60 05:17:00 INFO - 2017-04-20 05:17:00.253 screenresolution[1622:7338] starting screenresolution argv=screenresolution list 05:17:00 INFO - Available Modes on Display 0 05:17:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:17:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:17:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:17:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:17:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:17:00 INFO - Intel Iris: 05:17:00 INFO - Chipset Model: Intel Iris 05:17:00 INFO - Type: GPU 05:17:00 INFO - Bus: Built-In 05:17:00 INFO - VRAM (Dynamic, Max): 1536 MB 05:17:00 INFO - Vendor: Intel (0x8086) 05:17:00 INFO - Device ID: 0x0a2e 05:17:00 INFO - Revision ID: 0x0009 05:17:00 INFO - Displays: 05:17:00 INFO - Display: 05:17:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:17:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:17:00 INFO - Display Serial Number: 1600x1200 60 05:17:00 INFO - Main Display: Yes 05:17:00 INFO - Mirror: Off 05:17:00 INFO - Online: Yes 05:17:00 INFO - Rotation: Supported 05:17:00 INFO - Return code: 0 05:17:00 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 05:17:00 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 05:17:00 INFO - Python 2.7.3 05:17:00 INFO - Return code: 0 05:17:00 INFO - grabbing minidump binary from tooltool 05:17:00 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 05:17:00 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 0x1060d1d30>, '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 0x105ff7db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x1060c6be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 05:17:00 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 05:17:00 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 05:17:00 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 05:17:00 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 05:17:00 INFO - Return code: 0 05:17:00 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 05:17:00 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 05:17:00 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 05:17:00 INFO - ENV: RUST_BACKTRACE is now 1 05:17:00 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 05:17:00 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 05:17:00 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/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0356', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 05:17:00 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/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0356 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 05:17:00 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.k8ui64L1JJ/Render', 05:17:00 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 05:17:00 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 05:17:00 INFO - 'HOME': '/Users/cltbld', 05:17:00 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 05:17:00 INFO - 'LOGNAME': 'cltbld', 05:17:00 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 05:17:00 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 05:17:00 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 05:17:00 INFO - 'MOZ_NO_REMOTE': '1', 05:17:00 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 05:17:00 INFO - 'NO_EM_RESTART': '1', 05:17:00 INFO - 'PAGER': '/bin/cat', 05:17:00 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 05:17:00 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 05:17:00 INFO - 'PWD': '/builds/slave/test', 05:17:00 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 05:17:00 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 05:17:00 INFO - 'RUST_BACKTRACE': '1', 05:17:00 INFO - 'SHELL': '/bin/bash', 05:17:00 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.NrYg77tQQh/Listeners', 05:17:00 INFO - 'TMPDIR': '/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/', 05:17:00 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 05:17:00 INFO - 'USER': 'cltbld', 05:17:00 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 05:17:00 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 05:17:00 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 05:17:00 INFO - 'XPC_FLAGS': '0x0', 05:17:00 INFO - 'XPC_SERVICE_NAME': '0', 05:17:00 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 05:17:00 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/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0356', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 05:17:00 INFO - mozversion application_buildid: 20170420030346 05:17:00 INFO - mozversion application_changeset: 27311156637f9b5d4504373967e01c4241902ae7 05:17:00 INFO - mozversion application_display_name: Nightly 05:17:00 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 05:17:00 INFO - mozversion application_name: Firefox 05:17:00 INFO - mozversion application_remotingname: firefox 05:17:00 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 05:17:00 INFO - mozversion application_vendor: Mozilla 05:17:00 INFO - mozversion application_version: 55.0a1 05:17:00 INFO - mozversion platform_buildid: 20170420030346 05:17:00 INFO - mozversion platform_changeset: 27311156637f9b5d4504373967e01c4241902ae7 05:17:00 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 05:17:00 INFO - mozversion platform_version: 55.0a1 05:17:00 INFO - using testdate: 1492690620 05:17:00 INFO - actual date: 1492690620 05:17:00 INFO - starting webserver on 'localhost:49242' 05:17:00 INFO - SUITE-START | Running 2 tests 05:17:00 INFO - TEST-START | dromaeo_css 05:17:00 INFO - operating with platform_type : mac_ 05:17:00 INFO - Initialising browser for dromaeo_css test... 05:17:00 INFO - TEST-INFO | started process 1632 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmp2jBRxv/profile http://localhost:49242/getInfo.html) 05:17:03 INFO - PID 1632 | __metrics Screen width/height:1600/1200 05:17:03 INFO - PID 1632 | colorDepth:24 05:17:03 INFO - PID 1632 | Browser inner width/height: 1024/689 05:17:03 INFO - PID 1632 | __metrics 05:17:03 INFO - PID 1632 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:17:03 INFO - PID 1632 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:17:04 INFO - TEST-INFO | 1632: exit 0 05:17:04 INFO - Browser initialized. 05:17:04 INFO - Running cycle 1/1 for dromaeo_css test... 05:17:04 INFO - TEST-INFO | started process 1635 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmp2jBRxv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:17:16 INFO - PID 1635 | RSS: Main: 240988160 05:17:16 INFO - PID 1635 | 05:20:21 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49242/tests/dromaeo/cssquery-ext.html) 05:20:22 INFO - PID 1635 | RSS: Main: 402120704 05:20:22 INFO - PID 1635 | 05:22:06 INFO - PID 1635 | ************************* 05:22:06 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 05:22:06 INFO - PID 1635 | 05:22:06 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:22:06 INFO - PID 1635 | Full stack: 05:22:06 INFO - PID 1635 | ************************* 05:22:06 INFO - PID 1635 | ************************* 05:22:06 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 05:22:06 INFO - PID 1635 | 05:22:06 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:22:06 INFO - PID 1635 | Full stack: 05:22:06 INFO - PID 1635 | ************************* 05:22:06 INFO - PID 1635 | ************************* 05:22:06 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 05:22:06 INFO - PID 1635 | 05:22:06 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:22:06 INFO - PID 1635 | Full stack: 05:22:06 INFO - PID 1635 | ************************* 05:22:06 INFO - PID 1635 | ************************* 05:22:06 INFO - PID 1635 | A coding exception was thrown and uncaught in a Task. 05:22:06 INFO - PID 1635 | 05:22:06 ERROR - PID 1635 | Full message: TypeError: NetworkError when attempting to fetch resource. 05:22:06 INFO - PID 1635 | Full stack: 05:22:06 INFO - PID 1635 | ************************* 05:23:25 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-ext.html (next: http://localhost:49242/tests/dromaeo/cssquery-jquery.html) 05:23:26 INFO - PID 1635 | RSS: Main: 366862336 05:23:26 INFO - PID 1635 | 05:26:28 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49242/tests/dromaeo/cssquery-mootools.html) 05:26:28 INFO - PID 1635 | RSS: Main: 361590784 05:26:28 INFO - PID 1635 | 05:29:31 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49242/tests/dromaeo/cssquery-prototype.html) 05:29:31 INFO - PID 1635 | RSS: Main: 355258368 05:29:31 INFO - PID 1635 | 05:32:35 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49242/tests/dromaeo/cssquery-yui.html) 05:32:35 INFO - PID 1635 | RSS: Main: 332840960 05:32:35 INFO - PID 1635 | 05:35:38 INFO - PID 1635 | Cycle 1(1): loaded http://localhost:49242/tests/dromaeo/cssquery-yui.html (next: http://localhost:49242/tests/dromaeo/cssquery-dojo.html) 05:35:38 INFO - PID 1635 | RSS: Main: 375971840 05:35:38 INFO - PID 1635 | 05:35:38 INFO - PID 1635 | __start_tp_report 05:35:38 INFO - PID 1635 | _x_x_mozilla_page_load 05:35:38 INFO - PID 1635 | _x_x_mozilla_page_load_details 05:35:38 INFO - PID 1635 | |i|pagename|runs| 05:35:38 INFO - PID 1635 | |0;dojo.html;3419.572553430821;3451.9482207766887;3462.6018007929097;3483.6516348365167;3535.434330507118;6047.244094488189;6052.152698622191;6093.146959425684;6095.982463883834;6096.817095487142;6056.182415373934;6071.150038994544;6071.87856242876;6088.939110608892;6133.570650054498;4804.519548045202;5044.974775126119;5211.817586384477;5255.106631872572;5399.271098401724;5138.66598671087;5306.204069389603;5312.681239125645;5356.598255130881;5366.168243922179;5193.558547523465;5207.6875387476875;5219.530242278175;5220.4257531671865;5231.764570594332;5199.896002079975;5213.191955246943;5218.373795144569;5226.216067589854;5242.6330156889035;5104.25988231708;5171.793128274864;5180.119379705459;5185.818496352647;5189.6886186828915;5903.26209223847;5907.113932910055;5918.112283157561;5922.58541902067;5930.229070220844;6313.905291420632;6319.14691516644;6330.082138089997;6339.397757213057;6352.650604216767;6248.625082495065;6301.275353334379;6307;6418.293987661354;6491.058796474485;6162.198914141133;6171.321154672983;6184.319724830265;6197.008478643395;6201.100840378165;6630;6634.369734875179;6642.269350371455;6645.335466453316;6647.900281495781;6199.783007594712;6244.937550624527;6263.6241825490615;6266.24805023391;6304.338044505261;6312.905306420407;6367.458766004849;6384.010478375859;6441.581297215666;6442.645654488954;6316.115743795872;6352.110704501373;6354.491640668735;6361.141245931833;6362.459190968727;4898.706077635282;6295.276043254993;6335.936640633627;6352.7141278642575;6392.105105285264;4908.239222920453;5070.366204224472;5099.8725031873755;5151.716655583904;5152.819651312186;3911.4328422378594;4612.95387046132;4626.259798432235;4635.327877457749;4657.394538709946;6051.213342265565;6080.635161890213;6082.422169893853;6109.5112391008615;6112.144299798032;6272.686365681789;6319.778807741707;6426.453751431087;6491.610503369813;6536.673166341759;6102.458955353496;6109.860177052772;6125.47964319526;6125.84685382869;6142.140100385949;5676.943230567642;5686.943130568641;5687.658740475585;5698.686572238484;5699.686517241592;6363.395477429637;6438.774642887476;6704.396604305636;6706.865862682816;6708.932910670831;6442.935570644421;6470.48236141117;6498.3826536478955;6517.478601711757;6528.771492997722;6717.1267735194115;6729.057931889637;6729.057931889637;6735.764248251287;6736;6263.248410190807;6374.712873264644;6397.328280530477;6414.326495717883;6439.517036222396;5363.919541206807;6372.139761132188;6481.740730370732;6494.707738151889;6504.4796416285635;6287.434130928238;6306.9684651576445;6311.27420346666;6314.1160237565855;6319.368063193828;6155.599886007395;6168.352323006199;6231.719572619334;6238.126662267377;6267.2479302484;6222.81331560054;6236.688165591793;6248.0003199487865;6268.780592679417;6279.937200628118;6296.275928268308;6306.306306306395;6308.810735677937;6311.337309582611;6328.557001009885;6098.390160983866;6242.875142497215;6246.9062964054665;6254.249490061222;6280.1207830902795 05:35:38 INFO - PID 1635 | |1;ext.html;756.6330329790053;758.1054355860086;814.8451794159112;974.2936371130927;1116.3134672176614;27250.182494525146;36456.90629281119;36499.45250821233;36544.817275913585;36656.90029299125;38877.805610971904;39232.60767392325;39383.80308098455;39418.60581394185;39438;6156.630602163862;7177.5334603250885;8708.129187081304;8714.215720585145;8717.389782715212;6108.877822443548;8548.059713431518;8667.263282620985;8684.739457816244;8691.521966291852;8711.215990560848;8723.60743766532;8724.43291186074;8742.737717868475;8794.912050879506;8642.351823613222;8693.043765185825;8717.215450609476;8718.258947989429;8721.825563488695;8524.445911015826;8584;8584.785380365478;8585.699500517452;8586.527740974245;37092.70175543843;37294.25411491782;37316.44025339622;37356.13219339049;37364;3599.0642432967356;3624.075860655516;3626.7279954003293;3633.0190848470766;3637.563492380905;30632;30749.69250307513;30763.923262685923;30788.69211307903;30792.692073079208;3138.2311333723383;3193.425183466975;3217.147455924182;3225.193701574606;3228.935421291561;214607.99999999843;279443.20556794375;280249;281115.99999999796;282804;48878;48962.26556601654;49036.509634903196;49044.50955490471;49072.75463622659;51190.48809511932;51278.46164614993;51343.71640708938;51407.97184056298;51491.74254128705;13524.32378381077;13631.931840340734;13649.522266720616;13658;13667.384967676478;9706.369086009387;11139.275947063416;11147.219694621299;11187.888121118847;11194.720131996603;10613.575456981634;10689.091427228617;11868.584599538975;11912.76174476523;12060.457279422448;5144.948550514447;5153.17549192135;5174.586033117342;5184.351956005499;5193.324867767242;985.3496692183124;1009.1472705563787;1011.5801942194054;1045.749020235138;1051.458498873081;23176.65235021476;24338.63492047621;24528.50942981166;30372.93694720674;30748.69251307503;1049.5329578337567;1076.3219171921796;1079.438691880218;1097.13874608432;1119.9384033878214;10692.358458492516;10897.618583349546;12390;12397.814032789516;12406.937965310115;250138;304530;305959;306490;306851;50452.747736261816;50499;50727.239091413656;50803.49196508062;50819;1423.9572812815632;1472.2785834940803;1473.175021987669;1475.129673492623;1506.7061922924925;22812;23158.25255822586;23277.534449311257;23325.533489330457;23358.883205583865;37958.43062354122;37965.62034379621;38087.80956095202;38104.237915240985;38122;283981;284021;284410;284732;285707;32374.676253237165;32444.99767543012;32480.350392991535;32481;32593.511097333085;34958;37261.254774903806;42266.94332641709;42292;42341.576584233764;28597.571036434885;28715.99494017699;28868.422631546833;29626.703732962393;29916;28938.13185604435;29321.56017659694;29487.705122948497;29669.85165074161;29772.404551908407;35451.1796877326;35761.46357804687;35782.28435431225;35812.38844251963;35917.46123808093;27873.58189627198;28853.42293154167;28915.421691566473;30129.849350753106;30707.539386908767;23898.880505598056;23966.88016559906;23987.28038158858;24421.877890610434;24424.75575244225 05:35:38 INFO - PID 1635 | |2;jquery.html;443.5564435564436;444.3401548700178;446.09888026187105;446.8369045298466;466.98132074717034;21394.144234230633;22156.88921555392;22181.556368872614;22922;23187.420314492145;22492.43768905778;22717.091316347367;22920.85395730215;22950.426239344026;23278.836058197106;5979.491743201833;6051.576389652726;6118.1434599156155;6183.721732522047;6256.562040657156;6081.422264884829;6156.045812899008;6181.3818618138275;6183.1034499997695;6183.227096612924;5941.227640406741;6171;6204.100405441231;6206.2862770781485;6227.626342419469;5998.760049598054;6128.295246046717;6178.38216178383;6180.227471566031;6183.134361189437;5559.11054231321;5589.357223919261;5596.300462442195;5598.720063996825;5611.579131565149;26398.86800565985;27047.459050818874;27524.58713119305;27872;27934.860325698242;2230.141395562704;2267.1724820440586;2271.8977646005806;2272.2388000020014;2273.2043784675398;17090.145492725438;17677.292908283653;18178.363757268566;18318;18480.53798655031;2120.247312204176;2188;2191.6274233380364;2208.8564243324295;2209.0611490116635;149166;154333;155923;156982;159566.4043359575;11824.290542567473;12453.75092498145;12496.562620308245;12557.686057848627;12559.246445213317;16716.74924876128;16751.748723769153;16772.832271677373;16783.328666853187;16796.832031679525;7144.3212894774915;7183.712651493882;8587.184217499453;8799.552548346119;9003.14470125337;8243;8302.875456868152;8450.239478446969;8454.1123182065;8475.703350382708;7606.087269527692;7725.865326593403;7812.492188007761;7812.84374312522;7850.489718168415;1778.102058460495;1888.942192372276;2032.217596225464;2112.5880453311456;2277.692511510958;936.4287784451479;949.2738055387634;973.5473005052685;993.5677980078689;993.8360170571775;19803.603927921362;20986.370408887757;21116.366509004754;21289.36131916045;21417.357479275648;972.6352617768337;985.3989066669326;1018.2566726289701;1019.9592016319413;1024.2267088348249;10492.47537623131;10772.892271077346;10833.67498975032;10841.891581084246;10897.455127243606;531811;533342;541441;543773;544554;102158.48920755349;103980;115254;116589;116931;1139.3619573039125;1150.988490115088;1175.8530183727034;1176.006274697896;1176.976460470803;14859.405623775361;17992.460226193234;18177.818221818143;18191.90904045524;18197.545061373043;54064.729676351366;54334.369968900995;54669;55050;56744.71627641835;61171;69889.65055174692;71160;71453;73292;7694.384449243935;8580.227779499624;8783.824323513367;8892.666100085038;8912.465252084896;13736;13755.17468951866;13925;14286.214258215898;14310.642233944234;11686.532538698697;11764.529418823151;11805.468753906267;11980.221285616755;12088.879111209128;11008.449577521253;11066.28069175501;11072.667819965092;11476.827847582126;11496.425178741198;11734.823977640172;12158;12222.938885305517;12234.388280586114;12265.504331265547;8562.315014798925;8652.394332396923;8834.51410172421;8884.51135187545;9020.14308640678;9145.63417463294;11736.413179340829;11769.705757356134;11807.645770626896;11919 05:35:38 INFO - PID 1635 | |3;mootools.html;1193.2959553863218;1372.6568357910523;1430.1276221504886;1450.0647082631704;1455.556055403102;9797.70606881793;10234.590616375346;11659.591914282992;11692.473838677259;11930.985866201383;11512.539498420054;11599.362035088088;11602.651920442378;11623.012043976272;11625.360605166712;2518.1690042286045;2566.0633868637906;2569.56317426038;2571.4214301782044;2577.832440891336;2122.1935664447487;2188.245055455865;2196.8901554922268;2199.098369668436;2203.7025001624734;2174.4455163933253;2462.5567397868376;2540.390306326487;2549.9362515937155;2556.0159338654657;2501.862397568133;2529.962050569243;2536.5687833068423;2537.936551586207;2539.5047965646704;2488.377905523619;2508.636247744067;2515.408878913454;2522.4702812409414;2540.657011303469;11651.126165537535;11774.470148843322;11779.882201177965;11791.469383877746;11803.704907377298;6461.1600491936215;6703.597784132919;6711.731530738764;6722.731090756364;6730.293319201512;4046.1300820323772;4261.722988005769;4427.53510881356;4427.933580996288;4454.37638730578;1066.53605681528;1259.124908188809;1263.3241215949422;1314.480780091868;1314.763342598332;16708.916455417646;16717.582060448465;16744.83255167457;16745.83254167467;16759.66480670392;5793.681347525927;5867.383924687846;5905.586608937419;6028.246469191264;6056.788012419544;13763.724725505434;13782.862171378358;13785.103968242032;13818.37817298224;13863.514776982756;6778.2205046420295;6786.253512113663;6790.354916282945;6798.76204332846;6799.286074962157;5498.505134537911;5831.7667293307795;6207.441330280206;6222.439980401786;6227.439530442191;3822.2928758179823;4145.585441455831;4526.185286648435;4656.16189085961;4667.743274119888;1324.4106372664264;1343.5029039255537;1345.8384993800807;1348.8179095822134;1349.6558377613842;696.8501772118917;781.3280578702312;785.3873978296938;791.920807919215;806.705552473343;6831.146106736658;6835.350641689031;6886.657101865188;6969.512134150561;7079.398251148607;894.458852394305;916.1571354354011;926.6710317837205;931.8741969834122;952.8618350339162;3711.628837116321;4128.587141285848;4353.412289340962;4359.455068116486;4365.432493775789;14756.852431475763;15348.539543813704;15352.385904563916;15364.231788410534;15387.615309617126;14622.195779232032;15236.466723664618;15256;15321.310541025681;15379.846201538065;8443.57782110892;8662.263707584925;8667.089955554702;8703.869441958375;8710.695125670698;6655.966720166368;6943.618101004291;7117.3238542338395;7156.713731450684;7214;13444.193348399127;13457.259850708306;13839.792403114163;13856.960727945243;13868;13926.164430134224;13984.021118521607;14067.366968486647;14104.08323458972;14145.6463588407;9543;9732.61069557238;9740.318177727491;9756.902430975599;9779.511024448891;10552.525136369035;10779.89220107789;10867.619633312795;10872.347659140476;10886;9126.680566180152;9274.814503710022;9279.489628070522;9396.342256042011;9447.574859131219;7356.411487081128;9066.592003359732;9152.496612686366;9158.038405967278;9178.816423671622;8322.292605128632;8335.541545215072;8345.499270043816;8419.073901870666;8450.66197352099;6024.949393217273;6035.245594300713;6173.382661733791;6219.502439804714;6285.402886725937;5950;6136.754529818757;6263.467605253422;6269.937300627118;6320.936790632219 05:35:38 INFO - PID 1635 | |4;prototype.html;379.7911148868122;390.7635880292423;402.861012950532;420.13871563295237;420.8463910672602;5896.459726010974;5926.785009073141;5936.784882733254;5936.88126237475;5943.257092863392;5571.331440227168;5653.925754106717;5719.825496849247;5798.768049278024;5810.854728631786;3885.8251378687887;4009.1981603679237;4281.293586558229;4305.6124948754605;4311.827526898928;4311.525732169459;4335.783210839461;4341.17517671643;4342.370356298335;4356.344589056154;3636.7454278200535;4126.741343890112;4215.135897141079;4301.548337424572;4310.159518893817;4247.129338485603;4248.851290204859;4254.808533615979;4257.87226383209;4274.380214868842;3105.88188252229;3381.611114721814;3732.664060234592;3743.2887751327435;3782.167923056923;4945.554900059012;5130.4356520782685;5647.769131193156;5659.688717120557;5677.829665110012;5052.343195384613;5052.621053420971;5063.620228482879;5084.56781173597;5117.257997590365;6130.1609517145125;6161;6162.599431036968;6164.291106522763;6199.659018753967;3694.9445758313645;3989.7606143631474;4022.1955608878343;4119.711620186588;4173.1862286854075;6217.751289948396;6379.330170332141;6381.329960354189;6432.807015789534;6505;4059.6752259819145;4139.544650088488;4145.66834653227;4148.13778492839;4160.812763425653;3247.447933851251;3674.9448758268645;4223.282042052797;4300.204462174508;4322.913541729211;4865.294532292868;4977.5699627331705;5013.39839219296;5017.046761115376;5034.974825125851;5219.42586315505;5275.366955965309;5428.809991650273;5832.50423713989;6174.38256174379;1313.3892739876003;1418.432626949208;1467.4570408948757;1473.918934458615;1479.127314884202;726.7492715013312;880.4585180114184;917.8485549884327;982.9508524573743;983.6753871222479;4935.358403407606;5605.915911261334;5640.320847597441;5771.769129234784;5816.185733997244;5495.757503073206;5824.621399609012;6403.679816009181;6413.871722565523;6423.839404014937;5506.64206826563;5723.685197314105;5730.684812335361;5770.942290577041;5864.70676466175;3299.637039925606;3332.616749073839;3342.7325813934826;3348.547946027255;3350.66493350663;5552.52803511706;6294.370562943761;6564.4420224281475;6599.967000164968;6644.368784965421;5248.763805628756;5546.91679624806;6034.879302413927;6264.310925798159;6554.099311199794;5469.808556700496;5983;5998.550108741949;6012.917674818575;6578.3092775258865;5519.724013799374;6058.545609079249;6393.808185754435;6397.3366924599;6399.176234773067;6298.905516417166;6310.842228944313;6312.179416675803;6332.105754960574;6364.872702546016;5237.921431178459;5638.774449021993;6024.186734790923;6288.905666414916;6425.5502114851515;4238.067625122468;4240.618344349024;4244.639205667429;4249.830006799817;4259.87220383389;6082.026875700044;6122.653016336399;6254.593451425642;6385.7126429309865;6417.1657684500715;5152.433232344364;5711.3431955324;5991.460768530853;6165.691715414301;6235.719392627433;5662.7156249376085;5967.433093856251;6142.57002009855;6230.7819226326865;6395.584287021329;5368.516833485005;5817.476427121579;6008.708127752554;6050.2437195350585;6051.576389652858;6160.353162918008;6175.536834737502;6190.938090619216;6209.316975132641;6220.595661282183;5755.65466072037;5939.316978547349;5981.970090149522;6042.516598672008;6092.847678807888 05:35:38 INFO - PID 1635 | |5;yui.html;709.5529816215783;856.216561845911;863.2921004776086;863.4258218284837;874.5889431966975;13163.802542961852;18026.81973180268;18145;18716.251349945986;18784.53038674032;16659.00045997241;16832.579185520368;17203.91398043008;17236;17271.481855544323;953.0993211415233;987.9774433461369;998.0219385002702;1000.2298230362617;1005.7988402319529;680.7413182990457;1000.9199264058858;1006.2453160129902;1008.8486726990974;1009.6365308488975;752.5559919647407;1000.7940431779724;1048.4128887822806;1048.4390850894772;1053.8208504554207;1037.5590374090982;1038.901304376087;1041.9010194031555;1042.4683411460135;1048.5700862646318;771.7221800151941;772.4476998945725;777.6111944027986;779.5166996462173;786.6184900323339;15736;16073.678526429523;16300.592485187846;16617.83382166175;16835.410760623443;16448.671026579523;16515;16762.83237167637;16890.49328520134;16982.32070717182;13687.589372318846;13873.236971966538;13925.930370348186;14053.859461405358;14155;3402.2344972381266;3436.8453419595926;3438.2263990602164;3439.4840773884116;3446.844891979867;88831;110168.34747478794;110632.9999999992;111109.88890111077;111285;11095.38975356347;11956.40217989097;12104.939475302743;12147.453364598614;12189;19073.523161921064;19471.513212169524;24418.633720494207;24808;25031.62452563213;7701.383889288843;7900.525968441912;7901.525908445396;7901.841963160705;7904.288614024766;3890.144168282973;3935.8032098394965;3939.625735555118;3976.880693579197;3984.561698213194;4202.768847713405;4223;4246.4691913510815;4254.617084462413;4267.935980960288;861.4314552395389;866.5537248316996;900.522722956834;905.6603773584906;907.9319051071196;524.6406211744967;635.1584150999944;638.3329420755322;653.2520264297353;678.4572342126279;11208.943955280172;11746.530138794353;11953.342566158772;11969.281843089442;12025.699357515958;653.0889409274037;657.6843115304681;662.5097427903316;669.10340144207;676.0062707819498;5290.947090529123;5521.2270282160525;5539.335279766454;5634.464725851038;5661.433856614388;75089.24910750931;82094.17905820985;84638;91347;95214;72970.54058918792;73821.63089184627;75216;75728.24271757322;79748;69917.3008269921;71153;71497.28502715011;72060;72807.90788138182;9341.692163097036;11602.593909213138;11888.989435898045;12326.57204849027;12328.81506777417;26168;37439.81280093582;37648;37657.43513847349;38602;47356.763216183695;47647.76176119097;48086.5191348082;48101.51898480971;48553;15716.60708482297;15891.523254302389;16164.868459207742;16211.108389038716;16226.350945962502;17503.38738144159;17729.37947171843;17876.642467150323;18094.09529523545;18110;16163.272652730891;16283.53733078535;16324.183790810175;16393.344266229695;16617.91691041537;16043.598910027342;16112.758308625145;16192.271347789614;16257.51227463178;16294.755578666092;15812.446564370191;15955.441559545361;15990.600234994217;16065.67868642644;16166.949148305323;11408.429578521207;11485.483153257956;11900.880991189977;12029.518819247132;12088.15382923222;12831.294278814756;13727.245001525012;13840.86159138436;13854.238016909167;13870.722585548434 05:35:38 INFO - PID 1635 | __end_tp_report 05:35:38 INFO - PID 1635 | __start_cc_report 05:35:38 INFO - PID 1635 | _x_x_mozilla_cycle_collect,1591 05:35:38 INFO - PID 1635 | __end_cc_report 05:35:38 INFO - PID 1635 | __startTimestamp1492691738376__endTimestamp 05:35:38 INFO - PID 1635 | 05:35:38 INFO - PID 1635 | ------- Summary: start ------- 05:35:38 INFO - PID 1635 | Number of tests: 6 05:35:38 INFO - PID 1635 | 05:35:38 INFO - PID 1635 | [#0] dojo.html Cycles:165 Average:5931.86 Median:6231.72 stddev:703.99 (11.3%) stddev-sans-first:678.00 05:35:38 INFO - PID 1635 | Values: 3419.6 3451.9 3462.6 3483.7 3535.4 6047.2 6052.2 6093.1 6096.0 6096.8 6056.2 6071.2 6071.9 6088.9 6133.6 4804.5 5045.0 5211.8 5255.1 5399.3 5138.7 5306.2 5312.7 5356.6 5366.2 5193.6 5207.7 5219.5 5220.4 5231.8 5199.9 5213.2 5218.4 5226.2 5242.6 5104.3 5171.8 5180.1 5185.8 5189.7 5903.3 5907.1 5918.1 5922.6 5930.2 6313.9 6319.1 6330.1 6339.4 6352.7 6248.6 6301.3 6307.0 6418.3 6491.1 6162.2 6171.3 6184.3 6197.0 6201.1 6630.0 6634.4 6642.3 6645.3 6647.9 6199.8 6244.9 6263.6 6266.2 6304.3 6312.9 6367.5 6384.0 6441.6 6442.6 6316.1 6352.1 6354.5 6361.1 6362.5 4898.7 6295.3 6335.9 6352.7 6392.1 4908.2 5070.4 5099.9 5151.7 5152.8 3911.4 4613.0 4626.3 4635.3 4657.4 6051.2 6080.6 6082.4 6109.5 6112.1 6272.7 6319.8 6426.5 6491.6 6536.7 6102.5 6109.9 6125.5 6125.8 6142.1 5676.9 5686.9 5687.7 5698.7 5699.7 6363.4 6438.8 6704.4 6706.9 6708.9 6442.9 6470.5 6498.4 6517.5 6528.8 6717.1 6729.1 6729.1 6735.8 6736.0 6263.2 6374.7 6397.3 6414.3 6439.5 5363.9 6372.1 6481.7 6494.7 6504.5 6287.4 6307.0 6311.3 6314.1 6319.4 6155.6 6168.4 6231.7 6238.1 6267.2 6222.8 6236.7 6248.0 6268.8 6279.9 6296.3 6306.3 6308.8 6311.3 6328.6 6098.4 6242.9 6246.9 6254.2 6280.1 05:35:38 INFO - PID 1635 | 05:35:38 INFO - PID 1635 | [#1] ext.html Cycles:180 Average:43169.67 Median:32409.84 stddev:74200.67 (228.9%) stddev-sans-first:74340.48 05:35:38 INFO - PID 1635 | Values: 756.6 758.1 814.8 974.3 1116.3 27250.2 36456.9 36499.5 36544.8 36656.9 38877.8 39232.6 39383.8 39418.6 39438.0 6156.6 7177.5 8708.1 8714.2 8717.4 6108.9 8548.1 8667.3 8684.7 8691.5 8711.2 8723.6 8724.4 8742.7 8794.9 8642.4 8693.0 8717.2 8718.3 8721.8 8524.4 8584.0 8584.8 8585.7 8586.5 37092.7 37294.3 37316.4 37356.1 37364.0 3599.1 3624.1 3626.7 3633.0 3637.6 30632.0 30749.7 30763.9 30788.7 30792.7 3138.2 3193.4 3217.1 3225.2 3228.9 214608.0 279443.2 280249.0 281116.0 282804.0 48878.0 48962.3 49036.5 49044.5 49072.8 51190.5 51278.5 51343.7 51408.0 51491.7 13524.3 13631.9 13649.5 13658.0 13667.4 9706.4 11139.3 11147.2 11187.9 11194.7 10613.6 10689.1 11868.6 11912.8 12060.5 5144.9 5153.2 5174.6 5184.4 5193.3 985.3 1009.1 1011.6 1045.7 1051.5 23176.7 24338.6 24528.5 30372.9 30748.7 1049.5 1076.3 1079.4 1097.1 1119.9 10692.4 10897.6 12390.0 12397.8 12406.9 250138.0 304530.0 305959.0 306490.0 306851.0 50452.7 50499.0 50727.2 50803.5 50819.0 1424.0 1472.3 1473.2 1475.1 1506.7 22812.0 23158.3 23277.5 23325.5 23358.9 37958.4 37965.6 38087.8 38104.2 38122.0 283981.0 284021.0 284410.0 284732.0 285707.0 32374.7 32445.0 32480.4 32481.0 32593.5 34958.0 37261.3 42266.9 42292.0 42341.6 28597.6 28716.0 28868.4 29626.7 29916.0 28938.1 29321.6 29487.7 29669.9 29772.4 35451.2 35761.5 35782.3 35812.4 35917.5 27873.6 28853.4 28915.4 30129.8 30707.5 23898.9 23966.9 23987.3 24421.9 24424.8 05:35:38 INFO - PID 1635 | 05:35:38 INFO - PID 1635 | [#2] jquery.html Cycles:180 Average:34464.82 Median:2275.45 stddev:91046.25 (4001.2%) stddev-sans-first:91265.82 05:35:38 INFO - PID 1635 | Values: 443.6 444.3 446.1 446.8 467.0 21394.1 22156.9 22181.6 22922.0 23187.4 22492.4 22717.1 22920.9 22950.4 23278.8 5979.5 6051.6 6118.1 6183.7 6256.6 6081.4 6156.0 6181.4 6183.1 6183.2 5941.2 6171.0 6204.1 6206.3 6227.6 5998.8 6128.3 6178.4 6180.2 6183.1 5559.1 5589.4 5596.3 5598.7 5611.6 26398.9 27047.5 27524.6 27872.0 27934.9 2230.1 2267.2 2271.9 2272.2 2273.2 17090.1 17677.3 18178.4 18318.0 18480.5 2120.2 2188.0 2191.6 2208.9 2209.1 149166.0 154333.0 155923.0 156982.0 159566.4 11824.3 12453.8 12496.6 12557.7 12559.2 16716.7 16751.7 16772.8 16783.3 16796.8 7144.3 7183.7 8587.2 8799.6 9003.1 8243.0 8302.9 8450.2 8454.1 8475.7 7606.1 7725.9 7812.5 7812.8 7850.5 1778.1 1888.9 2032.2 2112.6 2277.7 936.4 949.3 973.5 993.6 993.8 19803.6 20986.4 21116.4 21289.4 21417.4 972.6 985.4 1018.3 1020.0 1024.2 10492.5 10772.9 10833.7 10841.9 10897.5 531811.0 533342.0 541441.0 543773.0 544554.0 102158.5 103980.0 115254.0 116589.0 116931.0 1139.4 1151.0 1175.9 1176.0 1177.0 14859.4 17992.5 18177.8 18191.9 18197.5 54064.7 54334.4 54669.0 55050.0 56744.7 61171.0 69889.7 71160.0 71453.0 73292.0 7694.4 8580.2 8783.8 8892.7 8912.5 13736.0 13755.2 13925.0 14286.2 14310.6 11686.5 11764.5 11805.5 11980.2 12088.9 11008.4 11066.3 11072.7 11476.8 11496.4 11734.8 12158.0 12222.9 12234.4 12265.5 8562.3 8652.4 8834.5 8884.5 9020.1 9145.6 11736.4 11769.7 11807.6 11919.0 05:35:38 INFO - PID 1635 | 05:35:38 INFO - PID 1635 | [#3] mootools.html Cycles:180 Average:7253.76 Median:3934.21 stddev:4627.27 (117.6%) stddev-sans-first:4617.84 05:35:38 INFO - PID 1635 | Values: 1193.3 1372.7 1430.1 1450.1 1455.6 9797.7 10234.6 11659.6 11692.5 11931.0 11512.5 11599.4 11602.7 11623.0 11625.4 2518.2 2566.1 2569.6 2571.4 2577.8 2122.2 2188.2 2196.9 2199.1 2203.7 2174.4 2462.6 2540.4 2549.9 2556.0 2501.9 2530.0 2536.6 2537.9 2539.5 2488.4 2508.6 2515.4 2522.5 2540.7 11651.1 11774.5 11779.9 11791.5 11803.7 6461.2 6703.6 6711.7 6722.7 6730.3 4046.1 4261.7 4427.5 4427.9 4454.4 1066.5 1259.1 1263.3 1314.5 1314.8 16708.9 16717.6 16744.8 16745.8 16759.7 5793.7 5867.4 5905.6 6028.2 6056.8 13763.7 13782.9 13785.1 13818.4 13863.5 6778.2 6786.3 6790.4 6798.8 6799.3 5498.5 5831.8 6207.4 6222.4 6227.4 3822.3 4145.6 4526.2 4656.2 4667.7 1324.4 1343.5 1345.8 1348.8 1349.7 696.9 781.3 785.4 791.9 806.7 6831.1 6835.4 6886.7 6969.5 7079.4 894.5 916.2 926.7 931.9 952.9 3711.6 4128.6 4353.4 4359.5 4365.4 14756.9 15348.5 15352.4 15364.2 15387.6 14622.2 15236.5 15256.0 15321.3 15379.8 8443.6 8662.3 8667.1 8703.9 8710.7 6656.0 6943.6 7117.3 7156.7 7214.0 13444.2 13457.3 13839.8 13857.0 13868.0 13926.2 13984.0 14067.4 14104.1 14145.6 9543.0 9732.6 9740.3 9756.9 9779.5 10552.5 10779.9 10867.6 10872.3 10886.0 9126.7 9274.8 9279.5 9396.3 9447.6 7356.4 9066.6 9152.5 9158.0 9178.8 8322.3 8335.5 8345.5 8419.1 8450.7 6024.9 6035.2 6173.4 6219.5 6285.4 5950.0 6136.8 6263.5 6269.9 6320.9 05:35:38 INFO - PID 1635 | 05:35:38 INFO - PID 1635 | [#4] prototype.html Cycles:180 Average:4953.05 Median:5650.85 stddev:1538.88 (27.2%) stddev-sans-first:1504.43 05:35:38 INFO - PID 1635 | Values: 379.8 390.8 402.9 420.1 420.8 5896.5 5926.8 5936.8 5936.9 5943.3 5571.3 5653.9 5719.8 5798.8 5810.9 3885.8 4009.2 4281.3 4305.6 4311.8 4311.5 4335.8 4341.2 4342.4 4356.3 3636.7 4126.7 4215.1 4301.5 4310.2 4247.1 4248.9 4254.8 4257.9 4274.4 3105.9 3381.6 3732.7 3743.3 3782.2 4945.6 5130.4 5647.8 5659.7 5677.8 5052.3 5052.6 5063.6 5084.6 5117.3 6130.2 6161.0 6162.6 6164.3 6199.7 3694.9 3989.8 4022.2 4119.7 4173.2 6217.8 6379.3 6381.3 6432.8 6505.0 4059.7 4139.5 4145.7 4148.1 4160.8 3247.4 3674.9 4223.3 4300.2 4322.9 4865.3 4977.6 5013.4 5017.0 5035.0 5219.4 5275.4 5428.8 5832.5 6174.4 1313.4 1418.4 1467.5 1473.9 1479.1 726.7 880.5 917.8 983.0 983.7 4935.4 5605.9 5640.3 5771.8 5816.2 5495.8 5824.6 6403.7 6413.9 6423.8 5506.6 5723.7 5730.7 5770.9 5864.7 3299.6 3332.6 3342.7 3348.5 3350.7 5552.5 6294.4 6564.4 6600.0 6644.4 5248.8 5546.9 6034.9 6264.3 6554.1 5469.8 5983.0 5998.6 6012.9 6578.3 5519.7 6058.5 6393.8 6397.3 6399.2 6298.9 6310.8 6312.2 6332.1 6364.9 5237.9 5638.8 6024.2 6288.9 6425.6 4238.1 4240.6 4244.6 4249.8 4259.9 6082.0 6122.7 6254.6 6385.7 6417.2 5152.4 5711.3 5991.5 6165.7 6235.7 5662.7 5967.4 6142.6 6230.8 6395.6 5368.5 5817.5 6008.7 6050.2 6051.6 6160.4 6175.5 6190.9 6209.3 6220.6 5755.7 5939.3 5982.0 6042.5 6092.8 05:35:38 INFO - PID 1635 | 05:35:38 INFO - PID 1635 | [#5] yui.html Cycles:180 Average:19506.47 Median:18430.63 stddev:25668.80 (139.3%) stddev-sans-first:25702.00 05:35:38 INFO - PID 1635 | Values: 709.6 856.2 863.3 863.4 874.6 13163.8 18026.8 18145.0 18716.3 18784.5 16659.0 16832.6 17203.9 17236.0 17271.5 953.1 988.0 998.0 1000.2 1005.8 680.7 1000.9 1006.2 1008.8 1009.6 752.6 1000.8 1048.4 1048.4 1053.8 1037.6 1038.9 1041.9 1042.5 1048.6 771.7 772.4 777.6 779.5 786.6 15736.0 16073.7 16300.6 16617.8 16835.4 16448.7 16515.0 16762.8 16890.5 16982.3 13687.6 13873.2 13925.9 14053.9 14155.0 3402.2 3436.8 3438.2 3439.5 3446.8 88831.0 110168.3 110633.0 111109.9 111285.0 11095.4 11956.4 12104.9 12147.5 12189.0 19073.5 19471.5 24418.6 24808.0 25031.6 7701.4 7900.5 7901.5 7901.8 7904.3 3890.1 3935.8 3939.6 3976.9 3984.6 4202.8 4223.0 4246.5 4254.6 4267.9 861.4 866.6 900.5 905.7 907.9 524.6 635.2 638.3 653.3 678.5 11208.9 11746.5 11953.3 11969.3 12025.7 653.1 657.7 662.5 669.1 676.0 5290.9 5521.2 5539.3 5634.5 5661.4 75089.2 82094.2 84638.0 91347.0 95214.0 72970.5 73821.6 75216.0 75728.2 79748.0 69917.3 71153.0 71497.3 72060.0 72807.9 9341.7 11602.6 11889.0 12326.6 12328.8 26168.0 37439.8 37648.0 37657.4 38602.0 47356.8 47647.8 48086.5 48101.5 48553.0 15716.6 15891.5 16164.9 16211.1 16226.4 17503.4 17729.4 17876.6 18094.1 18110.0 16163.3 16283.5 16324.2 16393.3 16617.9 16043.6 16112.8 16192.3 16257.5 16294.8 15812.4 15955.4 15990.6 16065.7 16166.9 11408.4 11485.5 11900.9 12029.5 12088.2 12831.3 13727.2 13840.9 13854.2 13870.7 05:35:38 INFO - PID 1635 | -------- Summary: end -------- 05:35:38 INFO - PID 1635 | 05:35:39 INFO - TEST-INFO | 1635: exit 0 05:35:39 INFO - TEST-OK | dromaeo_css | took 1118273ms 05:35:39 INFO - TEST-START | kraken 05:35:39 INFO - operating with platform_type : mac_ 05:35:39 INFO - Initialising browser for kraken test... 05:35:39 INFO - TEST-INFO | started process 1645 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpEAfMqv/profile http://localhost:49242/getInfo.html) 05:35:41 INFO - PID 1645 | __metrics Screen width/height:1600/1200 05:35:41 INFO - PID 1645 | colorDepth:24 05:35:41 INFO - PID 1645 | Browser inner width/height: 1024/689 05:35:41 INFO - PID 1645 | __metrics 05:35:42 INFO - PID 1645 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:35:42 INFO - PID 1645 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:35:42 INFO - TEST-INFO | 1645: exit 0 05:35:42 INFO - Browser initialized. 05:35:42 INFO - Running cycle 1/1 for kraken test... 05:35:42 INFO - TEST-INFO | started process 1647 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/T/tmpEAfMqv/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:35:55 INFO - PID 1647 | RSS: Main: 241197056 05:35:55 INFO - PID 1647 | 05:35:58 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection) 05:35:59 INFO - PID 1647 | RSS: Main: 311451648 05:35:59 INFO - PID 1647 | 05:36:01 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-dft) 05:36:02 INFO - PID 1647 | RSS: Main: 292954112 05:36:02 INFO - PID 1647 | 05:36:05 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-fft) 05:36:06 INFO - PID 1647 | RSS: Main: 384823296 05:36:06 INFO - PID 1647 | 05:36:08 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator) 05:36:08 INFO - PID 1647 | RSS: Main: 287121408 05:36:08 INFO - PID 1647 | 05:36:10 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:36:11 INFO - PID 1647 | RSS: Main: 289165312 05:36:11 INFO - PID 1647 | 05:36:14 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom) 05:36:14 INFO - PID 1647 | RSS: Main: 353017856 05:36:14 INFO - PID 1647 | 05:36:17 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate) 05:36:18 INFO - PID 1647 | RSS: Main: 376315904 05:36:18 INFO - PID 1647 | 05:36:20 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial) 05:36:21 INFO - PID 1647 | RSS: Main: 390426624 05:36:21 INFO - PID 1647 | 05:36:22 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:36:23 INFO - PID 1647 | RSS: Main: 332644352 05:36:23 INFO - PID 1647 | 05:36:25 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:36:26 INFO - PID 1647 | RSS: Main: 330268672 05:36:26 INFO - PID 1647 | 05:36:28 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:36:28 INFO - PID 1647 | RSS: Main: 333746176 05:36:28 INFO - PID 1647 | 05:36:31 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:36:32 INFO - PID 1647 | RSS: Main: 348278784 05:36:32 INFO - PID 1647 | 05:36:35 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:36:36 INFO - PID 1647 | RSS: Main: 329711616 05:36:36 INFO - PID 1647 | 05:36:38 INFO - PID 1647 | Cycle 1(1): loaded http://localhost:49242/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49242/tests/kraken/driver.html?testName=ai-astar) 05:36:38 INFO - PID 1647 | RSS: Main: 376041472 05:36:38 INFO - PID 1647 | 05:36:38 INFO - PID 1647 | __start_tp_report 05:36:38 INFO - PID 1647 | _x_x_mozilla_page_load 05:36:38 INFO - PID 1647 | _x_x_mozilla_page_load_details 05:36:38 INFO - PID 1647 | |i|pagename|runs| 05:36:38 INFO - PID 1647 | |0;ai-astar;111;111;110;111;111;117;161;94;152;163 05:36:38 INFO - PID 1647 | |1;audio-beat-detection;141;110;108;150;114;139;108;110;139;109 05:36:38 INFO - PID 1647 | |2;audio-dft;186;186;181;183;185;183;184;182;181;182 05:36:38 INFO - PID 1647 | |3;audio-fft;82;56;59;85;58;58;56;58;81;58 05:36:38 INFO - PID 1647 | |4;audio-oscillator;92;68;85;71;68;67;87;68;68;88 05:36:38 INFO - PID 1647 | |5;imaging-gaussian-blur;87;86;86;86;87;86;86;87;86;86 05:36:38 INFO - PID 1647 | |6;imaging-darkroom;94;94;94;94;93;94;94;94;93;94 05:36:38 INFO - PID 1647 | |7;imaging-desaturate;86;84;84;87;84;85;86;83;86;86 05:36:38 INFO - PID 1647 | |8;json-parse-financial;49;48;44;46;47;47;47;46;47;46 05:36:38 INFO - PID 1647 | |9;json-stringify-tinderbox;53;53;58;54;60;61;55;56;57;56 05:36:38 INFO - PID 1647 | |10;stanford-crypto-aes;82;82;83;83;83;82;83;83;81;82 05:36:38 INFO - PID 1647 | |11;stanford-crypto-ccm;142;147;143;139;132;136;135;135;177;142 05:36:38 INFO - PID 1647 | |12;stanford-crypto-pbkdf2;184;216;183;194;220;232;241;183;182;181 05:36:38 INFO - PID 1647 | |13;stanford-crypto-sha256-iterative;68;68;68;66;67;66;67;67;67;67 05:36:38 INFO - PID 1647 | __end_tp_report 05:36:38 INFO - PID 1647 | __start_cc_report 05:36:38 INFO - PID 1647 | _x_x_mozilla_cycle_collect,2176 05:36:38 INFO - PID 1647 | __end_cc_report 05:36:38 INFO - PID 1647 | __startTimestamp1492691798306__endTimestamp 05:36:38 INFO - PID 1647 | 05:36:38 INFO - PID 1647 | ------- Summary: start ------- 05:36:38 INFO - PID 1647 | Number of tests: 14 05:36:38 INFO - PID 1647 | 05:36:38 INFO - PID 1647 | [#0] ai-astar Cycles:10 Average:124.10 Median:134.50 stddev:24.71 (18.4%) stddev-sans-first:25.75 05:36:38 INFO - PID 1647 | Values: 111.0 111.0 110.0 111.0 111.0 117.0 161.0 94.0 152.0 163.0 05:36:38 INFO - PID 1647 | 05:36:38 INFO - PID 1647 | [#1] audio-beat-detection Cycles:10 Average:122.80 Median:126.50 stddev:17.09 (13.5%) stddev-sans-first:16.81 05:36:38 INFO - PID 1647 | Values: 141.0 110.0 108.0 150.0 114.0 139.0 108.0 110.0 139.0 109.0 05:36:38 INFO - PID 1647 | 05:36:38 INFO - PID 1647 | [#2] audio-dft Cycles:10 Average:183.30 Median:183.50 stddev:1.89 (1.0%) stddev-sans-first:1.73 05:36:38 INFO - PID 1647 | Values: 186.0 186.0 181.0 183.0 185.0 183.0 184.0 182.0 181.0 182.0 05:36:38 INFO - PID 1647 | 05:36:38 INFO - PID 1647 | [#3] audio-fft Cycles:10 Average:65.10 Median:58.50 stddev:12.20 (20.8%) stddev-sans-first:11.30 05:36:38 INFO - PID 1647 | Values: 82.0 56.0 59.0 85.0 58.0 58.0 56.0 58.0 81.0 58.0 05:36:38 INFO - PID 1647 | 05:36:38 INFO - PID 1647 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:78.00 stddev:10.35 (13.3%) stddev-sans-first:9.26 05:36:38 INFO - PID 1647 | Values: 92.0 68.0 85.0 71.0 68.0 67.0 87.0 68.0 68.0 88.0 05:36:38 INFO - PID 1647 | 05:36:38 INFO - PID 1647 | [#5] imaging-gaussian-blur Cycles:10 Average:86.30 Median:86.00 stddev:0.48 (0.6%) stddev-sans-first:0.44 05:36:38 INFO - PID 1647 | Values: 87.0 86.0 86.0 86.0 87.0 86.0 86.0 87.0 86.0 86.0 05:36:38 INFO - PID 1647 | 05:36:38 INFO - PID 1647 | [#6] imaging-darkroom Cycles:10 Average:93.80 Median:94.00 stddev:0.42 (0.4%) stddev-sans-first:0.44 05:36:38 INFO - PID 1647 | Values: 94.0 94.0 94.0 94.0 93.0 94.0 94.0 94.0 93.0 94.0 05:36:38 INFO - PID 1647 | 05:36:38 INFO - PID 1647 | [#7] imaging-desaturate Cycles:10 Average:85.10 Median:86.00 stddev:1.29 (1.5%) stddev-sans-first:1.32 05:36:38 INFO - PID 1647 | Values: 86.0 84.0 84.0 87.0 84.0 85.0 86.0 83.0 86.0 86.0 05:36:38 INFO - PID 1647 | 05:36:38 INFO - PID 1647 | [#8] json-parse-financial Cycles:10 Average:46.70 Median:47.00 stddev:1.34 (2.8%) stddev-sans-first:1.13 05:36:38 INFO - PID 1647 | Values: 49.0 48.0 44.0 46.0 47.0 47.0 47.0 46.0 47.0 46.0 05:36:38 INFO - PID 1647 | 05:36:38 INFO - PID 1647 | [#9] json-stringify-tinderbox Cycles:10 Average:56.30 Median:56.50 stddev:2.75 (4.9%) stddev-sans-first:2.65 05:36:38 INFO - PID 1647 | Values: 53.0 53.0 58.0 54.0 60.0 61.0 55.0 56.0 57.0 56.0 05:36:38 INFO - PID 1647 | 05:36:38 INFO - PID 1647 | [#10] stanford-crypto-aes Cycles:10 Average:82.40 Median:83.00 stddev:0.70 (0.8%) stddev-sans-first:0.73 05:36:38 INFO - PID 1647 | Values: 82.0 82.0 83.0 83.0 83.0 82.0 83.0 83.0 81.0 82.0 05:36:38 INFO - PID 1647 | 05:36:38 INFO - PID 1647 | [#11] stanford-crypto-ccm Cycles:10 Average:142.80 Median:142.00 stddev:12.86 (9.1%) stddev-sans-first:13.63 05:36:38 INFO - PID 1647 | Values: 142.0 147.0 143.0 139.0 132.0 136.0 135.0 135.0 177.0 142.0 05:36:38 INFO - PID 1647 | 05:36:38 INFO - PID 1647 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:201.60 Median:205.00 stddev:23.31 (11.4%) stddev-sans-first:23.84 05:36:38 INFO - PID 1647 | Values: 184.0 216.0 183.0 194.0 220.0 232.0 241.0 183.0 182.0 181.0 05:36:38 INFO - PID 1647 | 05:36:38 INFO - PID 1647 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.74 (1.1%) stddev-sans-first:0.71 05:36:38 INFO - PID 1647 | Values: 68.0 68.0 68.0 66.0 67.0 66.0 67.0 67.0 67.0 67.0 05:36:38 INFO - PID 1647 | -------- Summary: end -------- 05:36:38 INFO - PID 1647 | 05:36:39 INFO - TEST-INFO | 1647: exit 0 05:36:39 INFO - TEST-OK | kraken | took 60301ms 05:36:39 INFO - SUITE-END | took 1178s 05:36:39 INFO - Completed test suite (00:19:38) 05:36:39 INFO - javascript benchmark 05:36:39 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7663.48825799208, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3419.572553430821, 3451.9482207766887, 3462.6018007929097, 3483.6516348365167, 3535.434330507118, 6047.244094488189, 6052.152698622191, 6093.146959425684, 6095.982463883834, 6096.817095487142, 6056.182415373934, 6071.150038994544, 6071.87856242876, 6088.939110608892, 6133.570650054498, 4804.519548045202, 5044.974775126119, 5211.817586384477, 5255.106631872572, 5399.271098401724, 5138.66598671087, 5306.204069389603, 5312.681239125645, 5356.598255130881, 5366.168243922179, 5193.558547523465, 5207.6875387476875, 5219.530242278175, 5220.4257531671865, 5231.764570594332, 5199.896002079975, 5213.191955246943, 5218.373795144569, 5226.216067589854, 5242.6330156889035, 5104.25988231708, 5171.793128274864, 5180.119379705459, 5185.818496352647, 5189.6886186828915, 5903.26209223847, 5907.113932910055, 5918.112283157561, 5922.58541902067, 5930.229070220844, 6313.905291420632, 6319.14691516644, 6330.082138089997, 6339.397757213057, 6352.650604216767, 6248.625082495065, 6301.275353334379, 6307.0, 6418.293987661354, 6491.058796474485, 6162.198914141133, 6171.321154672983, 6184.319724830265, 6197.008478643395, 6201.100840378165, 6630.0, 6634.369734875179, 6642.269350371455, 6645.335466453316, 6647.900281495781, 6199.783007594712, 6244.937550624527, 6263.6241825490615, 6266.24805023391, 6304.338044505261, 6312.905306420407, 6367.458766004849, 6384.010478375859, 6441.581297215666, 6442.645654488954, 6316.115743795872, 6352.110704501373, 6354.491640668735, 6361.141245931833, 6362.459190968727, 4898.706077635282, 6295.276043254993, 6335.936640633627, 6352.7141278642575, 6392.105105285264, 4908.239222920453, 5070.366204224472, 5099.8725031873755, 5151.716655583904, 5152.819651312186, 3911.4328422378594, 4612.95387046132, 4626.259798432235, 4635.327877457749, 4657.394538709946, 6051.213342265565, 6080.635161890213, 6082.422169893853, 6109.5112391008615, 6112.144299798032, 6272.686365681789, 6319.778807741707, 6426.453751431087, 6491.610503369813, 6536.673166341759, 6102.458955353496, 6109.860177052772, 6125.47964319526, 6125.84685382869, 6142.140100385949, 5676.943230567642, 5686.943130568641, 5687.658740475585, 5698.686572238484, 5699.686517241592, 6363.395477429637, 6438.774642887476, 6704.396604305636, 6706.865862682816, 6708.932910670831, 6442.935570644421, 6470.48236141117, 6498.3826536478955, 6517.478601711757, 6528.771492997722, 6717.1267735194115, 6729.057931889637, 6729.057931889637, 6735.764248251287, 6736.0, 6263.248410190807, 6374.712873264644, 6397.328280530477, 6414.326495717883, 6439.517036222396, 5363.919541206807, 6372.139761132188, 6481.740730370732, 6494.707738151889, 6504.4796416285635, 6287.434130928238, 6306.9684651576445, 6311.27420346666, 6314.1160237565855, 6319.368063193828, 6155.599886007395, 6168.352323006199, 6231.719572619334, 6238.126662267377, 6267.2479302484, 6222.81331560054, 6236.688165591793, 6248.0003199487865, 6268.780592679417, 6279.937200628118, 6296.275928268308, 6306.306306306395, 6308.810735677937, 6311.337309582611, 6328.557001009885, 6098.390160983866, 6242.875142497215, 6246.9062964054665, 6254.249490061222, 6280.1207830902795], "value": 5884.804328433913, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [756.6330329790053, 758.1054355860086, 814.8451794159112, 974.2936371130927, 1116.3134672176614, 27250.182494525146, 36456.90629281119, 36499.45250821233, 36544.817275913585, 36656.90029299125, 38877.805610971904, 39232.60767392325, 39383.80308098455, 39418.60581394185, 39438.0, 6156.630602163862, 7177.5334603250885, 8708.129187081304, 8714.215720585145, 8717.389782715212, 6108.877822443548, 8548.059713431518, 8667.263282620985, 8684.739457816244, 8691.521966291852, 8711.215990560848, 8723.60743766532, 8724.43291186074, 8742.737717868475, 8794.912050879506, 8642.351823613222, 8693.043765185825, 8717.215450609476, 8718.258947989429, 8721.825563488695, 8524.445911015826, 8584.0, 8584.785380365478, 8585.699500517452, 8586.527740974245, 37092.70175543843, 37294.25411491782, 37316.44025339622, 37356.13219339049, 37364.0, 3599.0642432967356, 3624.075860655516, 3626.7279954003293, 3633.0190848470766, 3637.563492380905, 30632.0, 30749.69250307513, 30763.923262685923, 30788.69211307903, 30792.692073079208, 3138.2311333723383, 3193.425183466975, 3217.147455924182, 3225.193701574606, 3228.935421291561, 214607.99999999843, 279443.20556794375, 280249.0, 281115.99999999796, 282804.0, 48878.0, 48962.26556601654, 49036.509634903196, 49044.50955490471, 49072.75463622659, 51190.48809511932, 51278.46164614993, 51343.71640708938, 51407.97184056298, 51491.74254128705, 13524.32378381077, 13631.931840340734, 13649.522266720616, 13658.0, 13667.384967676478, 9706.369086009387, 11139.275947063416, 11147.219694621299, 11187.888121118847, 11194.720131996603, 10613.575456981634, 10689.091427228617, 11868.584599538975, 11912.76174476523, 12060.457279422448, 5144.948550514447, 5153.17549192135, 5174.586033117342, 5184.351956005499, 5193.324867767242, 985.3496692183124, 1009.1472705563787, 1011.5801942194054, 1045.749020235138, 1051.458498873081, 23176.65235021476, 24338.63492047621, 24528.50942981166, 30372.93694720674, 30748.69251307503, 1049.5329578337567, 1076.3219171921796, 1079.438691880218, 1097.13874608432, 1119.9384033878214, 10692.358458492516, 10897.618583349546, 12390.0, 12397.814032789516, 12406.937965310115, 250138.0, 304530.0, 305959.0, 306490.0, 306851.0, 50452.747736261816, 50499.0, 50727.239091413656, 50803.49196508062, 50819.0, 1423.9572812815632, 1472.2785834940803, 1473.175021987669, 1475.129673492623, 1506.7061922924925, 22812.0, 23158.25255822586, 23277.534449311257, 23325.533489330457, 23358.883205583865, 37958.43062354122, 37965.62034379621, 38087.80956095202, 38104.237915240985, 38122.0, 283981.0, 284021.0, 284410.0, 284732.0, 285707.0, 32374.676253237165, 32444.99767543012, 32480.350392991535, 32481.0, 32593.511097333085, 34958.0, 37261.254774903806, 42266.94332641709, 42292.0, 42341.576584233764, 28597.571036434885, 28715.99494017699, 28868.422631546833, 29626.703732962393, 29916.0, 28938.13185604435, 29321.56017659694, 29487.705122948497, 29669.85165074161, 29772.404551908407, 35451.1796877326, 35761.46357804687, 35782.28435431225, 35812.38844251963, 35917.46123808093, 27873.58189627198, 28853.42293154167, 28915.421691566473, 30129.849350753106, 30707.539386908767, 23898.880505598056, 23966.88016559906, 23987.28038158858, 24421.877890610434, 24424.75575244225], "value": 17034.289639051556, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [443.5564435564436, 444.3401548700178, 446.09888026187105, 446.8369045298466, 466.98132074717034, 21394.144234230633, 22156.88921555392, 22181.556368872614, 22922.0, 23187.420314492145, 22492.43768905778, 22717.091316347367, 22920.85395730215, 22950.426239344026, 23278.836058197106, 5979.491743201833, 6051.576389652726, 6118.1434599156155, 6183.721732522047, 6256.562040657156, 6081.422264884829, 6156.045812899008, 6181.3818618138275, 6183.1034499997695, 6183.227096612924, 5941.227640406741, 6171.0, 6204.100405441231, 6206.2862770781485, 6227.626342419469, 5998.760049598054, 6128.295246046717, 6178.38216178383, 6180.227471566031, 6183.134361189437, 5559.11054231321, 5589.357223919261, 5596.300462442195, 5598.720063996825, 5611.579131565149, 26398.86800565985, 27047.459050818874, 27524.58713119305, 27872.0, 27934.860325698242, 2230.141395562704, 2267.1724820440586, 2271.8977646005806, 2272.2388000020014, 2273.2043784675398, 17090.145492725438, 17677.292908283653, 18178.363757268566, 18318.0, 18480.53798655031, 2120.247312204176, 2188.0, 2191.6274233380364, 2208.8564243324295, 2209.0611490116635, 149166.0, 154333.0, 155923.0, 156982.0, 159566.4043359575, 11824.290542567473, 12453.75092498145, 12496.562620308245, 12557.686057848627, 12559.246445213317, 16716.74924876128, 16751.748723769153, 16772.832271677373, 16783.328666853187, 16796.832031679525, 7144.3212894774915, 7183.712651493882, 8587.184217499453, 8799.552548346119, 9003.14470125337, 8243.0, 8302.875456868152, 8450.239478446969, 8454.1123182065, 8475.703350382708, 7606.087269527692, 7725.865326593403, 7812.492188007761, 7812.84374312522, 7850.489718168415, 1778.102058460495, 1888.942192372276, 2032.217596225464, 2112.5880453311456, 2277.692511510958, 936.4287784451479, 949.2738055387634, 973.5473005052685, 993.5677980078689, 993.8360170571775, 19803.603927921362, 20986.370408887757, 21116.366509004754, 21289.36131916045, 21417.357479275648, 972.6352617768337, 985.3989066669326, 1018.2566726289701, 1019.9592016319413, 1024.2267088348249, 10492.47537623131, 10772.892271077346, 10833.67498975032, 10841.891581084246, 10897.455127243606, 531811.0, 533342.0, 541441.0, 543773.0, 544554.0, 102158.48920755349, 103980.0, 115254.0, 116589.0, 116931.0, 1139.3619573039125, 1150.988490115088, 1175.8530183727034, 1176.006274697896, 1176.976460470803, 14859.405623775361, 17992.460226193234, 18177.818221818143, 18191.90904045524, 18197.545061373043, 54064.729676351366, 54334.369968900995, 54669.0, 55050.0, 56744.71627641835, 61171.0, 69889.65055174692, 71160.0, 71453.0, 73292.0, 7694.384449243935, 8580.227779499624, 8783.824323513367, 8892.666100085038, 8912.465252084896, 13736.0, 13755.17468951866, 13925.0, 14286.214258215898, 14310.642233944234, 11686.532538698697, 11764.529418823151, 11805.468753906267, 11980.221285616755, 12088.879111209128, 11008.449577521253, 11066.28069175501, 11072.667819965092, 11476.827847582126, 11496.425178741198, 11734.823977640172, 12158.0, 12222.938885305517, 12234.388280586114, 12265.504331265547, 8562.315014798925, 8652.394332396923, 8834.51410172421, 8884.51135187545, 9020.14308640678, 9145.63417463294, 11736.413179340829, 11769.705757356134, 11807.645770626896, 11919.0], "value": 10310.135583326195, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1193.2959553863218, 1372.6568357910523, 1430.1276221504886, 1450.0647082631704, 1455.556055403102, 9797.70606881793, 10234.590616375346, 11659.591914282992, 11692.473838677259, 11930.985866201383, 11512.539498420054, 11599.362035088088, 11602.651920442378, 11623.012043976272, 11625.360605166712, 2518.1690042286045, 2566.0633868637906, 2569.56317426038, 2571.4214301782044, 2577.832440891336, 2122.1935664447487, 2188.245055455865, 2196.8901554922268, 2199.098369668436, 2203.7025001624734, 2174.4455163933253, 2462.5567397868376, 2540.390306326487, 2549.9362515937155, 2556.0159338654657, 2501.862397568133, 2529.962050569243, 2536.5687833068423, 2537.936551586207, 2539.5047965646704, 2488.377905523619, 2508.636247744067, 2515.408878913454, 2522.4702812409414, 2540.657011303469, 11651.126165537535, 11774.470148843322, 11779.882201177965, 11791.469383877746, 11803.704907377298, 6461.1600491936215, 6703.597784132919, 6711.731530738764, 6722.731090756364, 6730.293319201512, 4046.1300820323772, 4261.722988005769, 4427.53510881356, 4427.933580996288, 4454.37638730578, 1066.53605681528, 1259.124908188809, 1263.3241215949422, 1314.480780091868, 1314.763342598332, 16708.916455417646, 16717.582060448465, 16744.83255167457, 16745.83254167467, 16759.66480670392, 5793.681347525927, 5867.383924687846, 5905.586608937419, 6028.246469191264, 6056.788012419544, 13763.724725505434, 13782.862171378358, 13785.103968242032, 13818.37817298224, 13863.514776982756, 6778.2205046420295, 6786.253512113663, 6790.354916282945, 6798.76204332846, 6799.286074962157, 5498.505134537911, 5831.7667293307795, 6207.441330280206, 6222.439980401786, 6227.439530442191, 3822.2928758179823, 4145.585441455831, 4526.185286648435, 4656.16189085961, 4667.743274119888, 1324.4106372664264, 1343.5029039255537, 1345.8384993800807, 1348.8179095822134, 1349.6558377613842, 696.8501772118917, 781.3280578702312, 785.3873978296938, 791.920807919215, 806.705552473343, 6831.146106736658, 6835.350641689031, 6886.657101865188, 6969.512134150561, 7079.398251148607, 894.458852394305, 916.1571354354011, 926.6710317837205, 931.8741969834122, 952.8618350339162, 3711.628837116321, 4128.587141285848, 4353.412289340962, 4359.455068116486, 4365.432493775789, 14756.852431475763, 15348.539543813704, 15352.385904563916, 15364.231788410534, 15387.615309617126, 14622.195779232032, 15236.466723664618, 15256.0, 15321.310541025681, 15379.846201538065, 8443.57782110892, 8662.263707584925, 8667.089955554702, 8703.869441958375, 8710.695125670698, 6655.966720166368, 6943.618101004291, 7117.3238542338395, 7156.713731450684, 7214.0, 13444.193348399127, 13457.259850708306, 13839.792403114163, 13856.960727945243, 13868.0, 13926.164430134224, 13984.021118521607, 14067.366968486647, 14104.08323458972, 14145.6463588407, 9543.0, 9732.61069557238, 9740.318177727491, 9756.902430975599, 9779.511024448891, 10552.525136369035, 10779.89220107789, 10867.619633312795, 10872.347659140476, 10886.0, 9126.680566180152, 9274.814503710022, 9279.489628070522, 9396.342256042011, 9447.574859131219, 7356.411487081128, 9066.592003359732, 9152.496612686366, 9158.038405967278, 9178.816423671622, 8322.292605128632, 8335.541545215072, 8345.499270043816, 8419.073901870666, 8450.66197352099, 6024.949393217273, 6035.245594300713, 6173.382661733791, 6219.502439804714, 6285.402886725937, 5950.0, 6136.754529818757, 6263.467605253422, 6269.937300627118, 6320.936790632219], "value": 5450.412202990013, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [379.7911148868122, 390.7635880292423, 402.861012950532, 420.13871563295237, 420.8463910672602, 5896.459726010974, 5926.785009073141, 5936.784882733254, 5936.88126237475, 5943.257092863392, 5571.331440227168, 5653.925754106717, 5719.825496849247, 5798.768049278024, 5810.854728631786, 3885.8251378687887, 4009.1981603679237, 4281.293586558229, 4305.6124948754605, 4311.827526898928, 4311.525732169459, 4335.783210839461, 4341.17517671643, 4342.370356298335, 4356.344589056154, 3636.7454278200535, 4126.741343890112, 4215.135897141079, 4301.548337424572, 4310.159518893817, 4247.129338485603, 4248.851290204859, 4254.808533615979, 4257.87226383209, 4274.380214868842, 3105.88188252229, 3381.611114721814, 3732.664060234592, 3743.2887751327435, 3782.167923056923, 4945.554900059012, 5130.4356520782685, 5647.769131193156, 5659.688717120557, 5677.829665110012, 5052.343195384613, 5052.621053420971, 5063.620228482879, 5084.56781173597, 5117.257997590365, 6130.1609517145125, 6161.0, 6162.599431036968, 6164.291106522763, 6199.659018753967, 3694.9445758313645, 3989.7606143631474, 4022.1955608878343, 4119.711620186588, 4173.1862286854075, 6217.751289948396, 6379.330170332141, 6381.329960354189, 6432.807015789534, 6505.0, 4059.6752259819145, 4139.544650088488, 4145.66834653227, 4148.13778492839, 4160.812763425653, 3247.447933851251, 3674.9448758268645, 4223.282042052797, 4300.204462174508, 4322.913541729211, 4865.294532292868, 4977.5699627331705, 5013.39839219296, 5017.046761115376, 5034.974825125851, 5219.42586315505, 5275.366955965309, 5428.809991650273, 5832.50423713989, 6174.38256174379, 1313.3892739876003, 1418.432626949208, 1467.4570408948757, 1473.918934458615, 1479.127314884202, 726.7492715013312, 880.4585180114184, 917.8485549884327, 982.9508524573743, 983.6753871222479, 4935.358403407606, 5605.915911261334, 5640.320847597441, 5771.769129234784, 5816.185733997244, 5495.757503073206, 5824.621399609012, 6403.679816009181, 6413.871722565523, 6423.839404014937, 5506.64206826563, 5723.685197314105, 5730.684812335361, 5770.942290577041, 5864.70676466175, 3299.637039925606, 3332.616749073839, 3342.7325813934826, 3348.547946027255, 3350.66493350663, 5552.52803511706, 6294.370562943761, 6564.4420224281475, 6599.967000164968, 6644.368784965421, 5248.763805628756, 5546.91679624806, 6034.879302413927, 6264.310925798159, 6554.099311199794, 5469.808556700496, 5983.0, 5998.550108741949, 6012.917674818575, 6578.3092775258865, 5519.724013799374, 6058.545609079249, 6393.808185754435, 6397.3366924599, 6399.176234773067, 6298.905516417166, 6310.842228944313, 6312.179416675803, 6332.105754960574, 6364.872702546016, 5237.921431178459, 5638.774449021993, 6024.186734790923, 6288.905666414916, 6425.5502114851515, 4238.067625122468, 4240.618344349024, 4244.639205667429, 4249.830006799817, 4259.87220383389, 6082.026875700044, 6122.653016336399, 6254.593451425642, 6385.7126429309865, 6417.1657684500715, 5152.433232344364, 5711.3431955324, 5991.460768530853, 6165.691715414301, 6235.719392627433, 5662.7156249376085, 5967.433093856251, 6142.57002009855, 6230.7819226326865, 6395.584287021329, 5368.516833485005, 5817.476427121579, 6008.708127752554, 6050.2437195350585, 6051.576389652858, 6160.353162918008, 6175.536834737502, 6190.938090619216, 6209.316975132641, 6220.595661282183, 5755.65466072037, 5939.316978547349, 5981.970090149522, 6042.516598672008, 6092.847678807888], "value": 4474.156891492202, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [709.5529816215783, 856.216561845911, 863.2921004776086, 863.4258218284837, 874.5889431966975, 13163.802542961852, 18026.81973180268, 18145.0, 18716.251349945986, 18784.53038674032, 16659.00045997241, 16832.579185520368, 17203.91398043008, 17236.0, 17271.481855544323, 953.0993211415233, 987.9774433461369, 998.0219385002702, 1000.2298230362617, 1005.7988402319529, 680.7413182990457, 1000.9199264058858, 1006.2453160129902, 1008.8486726990974, 1009.6365308488975, 752.5559919647407, 1000.7940431779724, 1048.4128887822806, 1048.4390850894772, 1053.8208504554207, 1037.5590374090982, 1038.901304376087, 1041.9010194031555, 1042.4683411460135, 1048.5700862646318, 771.7221800151941, 772.4476998945725, 777.6111944027986, 779.5166996462173, 786.6184900323339, 15736.0, 16073.678526429523, 16300.592485187846, 16617.83382166175, 16835.410760623443, 16448.671026579523, 16515.0, 16762.83237167637, 16890.49328520134, 16982.32070717182, 13687.589372318846, 13873.236971966538, 13925.930370348186, 14053.859461405358, 14155.0, 3402.2344972381266, 3436.8453419595926, 3438.2263990602164, 3439.4840773884116, 3446.844891979867, 88831.0, 110168.34747478794, 110632.9999999992, 111109.88890111077, 111285.0, 11095.38975356347, 11956.40217989097, 12104.939475302743, 12147.453364598614, 12189.0, 19073.523161921064, 19471.513212169524, 24418.633720494207, 24808.0, 25031.62452563213, 7701.383889288843, 7900.525968441912, 7901.525908445396, 7901.841963160705, 7904.288614024766, 3890.144168282973, 3935.8032098394965, 3939.625735555118, 3976.880693579197, 3984.561698213194, 4202.768847713405, 4223.0, 4246.4691913510815, 4254.617084462413, 4267.935980960288, 861.4314552395389, 866.5537248316996, 900.522722956834, 905.6603773584906, 907.9319051071196, 524.6406211744967, 635.1584150999944, 638.3329420755322, 653.2520264297353, 678.4572342126279, 11208.943955280172, 11746.530138794353, 11953.342566158772, 11969.281843089442, 12025.699357515958, 653.0889409274037, 657.6843115304681, 662.5097427903316, 669.10340144207, 676.0062707819498, 5290.947090529123, 5521.2270282160525, 5539.335279766454, 5634.464725851038, 5661.433856614388, 75089.24910750931, 82094.17905820985, 84638.0, 91347.0, 95214.0, 72970.54058918792, 73821.63089184627, 75216.0, 75728.24271757322, 79748.0, 69917.3008269921, 71153.0, 71497.28502715011, 72060.0, 72807.90788138182, 9341.692163097036, 11602.593909213138, 11888.989435898045, 12326.57204849027, 12328.81506777417, 26168.0, 37439.81280093582, 37648.0, 37657.43513847349, 38602.0, 47356.763216183695, 47647.76176119097, 48086.5191348082, 48101.51898480971, 48553.0, 15716.60708482297, 15891.523254302389, 16164.868459207742, 16211.108389038716, 16226.350945962502, 17503.38738144159, 17729.37947171843, 17876.642467150323, 18094.09529523545, 18110.0, 16163.272652730891, 16283.53733078535, 16324.183790810175, 16393.344266229695, 16617.91691041537, 16043.598910027342, 16112.758308625145, 16192.271347789614, 16257.51227463178, 16294.755578666092, 15812.446564370191, 15955.441559545361, 15990.600234994217, 16065.67868642644, 16166.949148305323, 11408.429578521207, 11485.483153257956, 11900.880991189977, 12029.518819247132, 12088.15382923222, 12831.294278814756, 13727.245001525012, 13840.86159138436, 13854.238016909167, 13870.722585548434], "value": 8036.4790181064145, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1433.5999999999997, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 110.0, 111.0, 111.0, 117.0, 161.0, 94.0, 152.0, 163.0], "value": 124.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [141.0, 110.0, 108.0, 150.0, 114.0, 139.0, 108.0, 110.0, 139.0, 109.0], "value": 122.8, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 181.0, 183.0, 185.0, 183.0, 184.0, 182.0, 181.0, 182.0], "value": 183.3, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 56.0, 59.0, 85.0, 58.0, 58.0, 56.0, 58.0, 81.0, 58.0], "value": 65.1, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 68.0, 85.0, 71.0, 68.0, 67.0, 87.0, 68.0, 68.0, 88.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 86.0, 86.0, 86.0, 87.0, 86.0, 86.0, 87.0, 86.0, 86.0], "value": 86.3, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 94.0, 94.0, 94.0, 93.0, 94.0, 94.0, 94.0, 93.0, 94.0], "value": 93.8, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 87.0, 84.0, 85.0, 86.0, 83.0, 86.0, 86.0], "value": 85.1, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [49.0, 48.0, 44.0, 46.0, 47.0, 47.0, 47.0, 46.0, 47.0, 46.0], "value": 46.7, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [53.0, 53.0, 58.0, 54.0, 60.0, 61.0, 55.0, 56.0, 57.0, 56.0], "value": 56.3, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [82.0, 82.0, 83.0, 83.0, 83.0, 82.0, 83.0, 83.0, 81.0, 82.0], "value": 82.4, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 147.0, 143.0, 139.0, 132.0, 136.0, 135.0, 135.0, 177.0, 142.0], "value": 142.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [184.0, 216.0, 183.0, 194.0, 220.0, 232.0, 241.0, 183.0, 182.0, 181.0], "value": 201.6, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 68.0, 68.0, 66.0, 67.0, 66.0, 67.0, 67.0, 67.0, 67.0], "value": 67.1, "unit": "score"}]}]} 05:36:39 INFO - Return code: 0 05:36:39 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:36:39 ERROR - # TBPL SUCCESS # 05:36:39 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:36:39 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:36:39 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:36:39 INFO - 2017-04-20 05:36:39.609 screenresolution[1651:9752] starting screenresolution argv=screenresolution get 05:36:39 INFO - 2017-04-20 05:36:39.612 screenresolution[1651:9752] Display 0: 1600x1200x32@60 05:36:39 INFO - 2017-04-20 05:36:39.618 screenresolution[1652:9756] starting screenresolution argv=screenresolution list 05:36:39 INFO - Available Modes on Display 0 05:36:39 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:36:39 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:36:39 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:36:39 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:36:39 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:36:39 INFO - Intel Iris: 05:36:39 INFO - Chipset Model: Intel Iris 05:36:39 INFO - Type: GPU 05:36:39 INFO - Bus: Built-In 05:36:39 INFO - VRAM (Dynamic, Max): 1536 MB 05:36:39 INFO - Vendor: Intel (0x8086) 05:36:39 INFO - Device ID: 0x0a2e 05:36:39 INFO - Revision ID: 0x0009 05:36:39 INFO - Displays: 05:36:39 INFO - Display: 05:36:39 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:36:39 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:36:39 INFO - Display Serial Number: 1600x1200 60 05:36:39 INFO - Main Display: Yes 05:36:39 INFO - Mirror: Off 05:36:39 INFO - Online: Yes 05:36:39 INFO - Rotation: Supported 05:36:39 INFO - Return code: 0 05:36:39 INFO - Running post-action listener: _resource_record_post_action 05:36:39 INFO - [mozharness: 2017-04-20 12:36:39.872085Z] Finished run-tests step (success) 05:36:39 INFO - Running post-run listener: _resource_record_post_run 05:36:39 INFO - Total resource usage - Wall time: 1198s; CPU: 53.0%; Read bytes: 37897216; Write bytes: 512629248; Read time: 238; Write time: 1601 05:36:39 INFO - TinderboxPrint: CPU usage
53.4% 05:36:39 INFO - TinderboxPrint: I/O read bytes / time
37,897,216 / 238 05:36:39 INFO - TinderboxPrint: I/O write bytes / time
512,629,248 / 1,601 05:36:39 INFO - TinderboxPrint: CPU idle
2,232.5 (46.6%) 05:36:39 INFO - TinderboxPrint: CPU system
957.8 (20.0%) 05:36:39 INFO - TinderboxPrint: CPU user
1,603.4 (33.4%) 05:36:39 INFO - TinderboxPrint: Swap in / out
245,739,520 / 0 05:36:39 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 198654464; Write bytes: 195094528; Read time: 14915; Write time: 408 05:36:39 INFO - run-tests - Wall time: 1180s; CPU: 53.0%; Read bytes: 36934656; Write bytes: 300708352; Read time: 226; Write time: 1142 05:36:40 INFO - Running post-run listener: _upload_blobber_files 05:36:40 INFO - Blob upload gear active. 05:36:40 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:36:40 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:36:40 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'] 05:36:40 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 05:36:40 INFO - (blobuploader) - INFO - Open directory for files ... 05:36:40 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:36:40 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:40 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:41 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:36:41 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:41 INFO - (blobuploader) - INFO - Done attempting. 05:36:41 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:36:41 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:41 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:42 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:36:42 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:42 INFO - (blobuploader) - INFO - Done attempting. 05:36:42 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:36:42 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:42 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:43 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:36:43 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:43 INFO - (blobuploader) - INFO - Done attempting. 05:36:43 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:36:43 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:36:43 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:36:45 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:36:45 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:36:45 INFO - (blobuploader) - INFO - Done attempting. 05:36:45 INFO - (blobuploader) - INFO - Iteration through files over. 05:36:45 INFO - Return code: 0 05:36:45 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:36:45 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:36:45 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aae8aaeea2590c1895bf8d71611e83bebab58020b39b2c72ea8ee2e95d3da8d1fd3fb8560af92a7b35c2167edcee916d3e91c7dd13b4bb8ac5d25e120ab98762", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6827cb43793a3b6c60dc105825165d55087a6bfac0dfe3583265008c4f36e289edcda97721aa3820ec9688551b18379ccf3c22727efeb78582eee6b074172e4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d25879632a44fc547c897605180c3987b745e1da8c39b0da6f25d9bb1f272d841dc95c00100c85e1fa528e0264c98660daef6724c57b715dfe500cb41d4e094a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5714b4c12cbe5759149e6d4c161ddf7fa54b6ba04b002ee41b6caa1d966a20d10770d681d961d613d1187c96deec0dca5f382496721ce6fc62d75fc91284635d"} 05:36:45 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:36:45 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:36:45 INFO - Contents: 05:36:45 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/aae8aaeea2590c1895bf8d71611e83bebab58020b39b2c72ea8ee2e95d3da8d1fd3fb8560af92a7b35c2167edcee916d3e91c7dd13b4bb8ac5d25e120ab98762", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6827cb43793a3b6c60dc105825165d55087a6bfac0dfe3583265008c4f36e289edcda97721aa3820ec9688551b18379ccf3c22727efeb78582eee6b074172e4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d25879632a44fc547c897605180c3987b745e1da8c39b0da6f25d9bb1f272d841dc95c00100c85e1fa528e0264c98660daef6724c57b715dfe500cb41d4e094a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5714b4c12cbe5759149e6d4c161ddf7fa54b6ba04b002ee41b6caa1d966a20d10770d681d961d613d1187c96deec0dca5f382496721ce6fc62d75fc91284635d"} 05:36:45 INFO - Running post-run listener: copy_logs_to_upload_dir 05:36:45 INFO - Copying logs to upload dir... 05:36:45 INFO - mkdir: /builds/slave/test/build/upload/logs 05:36:45 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1281.675085 ========= master_lag: 0.04 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 21 secs) (at 2017-04-20 05:36:45.963502) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-20 05:36:45.967124) ========= 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.k8ui64L1JJ/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.NrYg77tQQh/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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/aae8aaeea2590c1895bf8d71611e83bebab58020b39b2c72ea8ee2e95d3da8d1fd3fb8560af92a7b35c2167edcee916d3e91c7dd13b4bb8ac5d25e120ab98762", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6827cb43793a3b6c60dc105825165d55087a6bfac0dfe3583265008c4f36e289edcda97721aa3820ec9688551b18379ccf3c22727efeb78582eee6b074172e4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d25879632a44fc547c897605180c3987b745e1da8c39b0da6f25d9bb1f272d841dc95c00100c85e1fa528e0264c98660daef6724c57b715dfe500cb41d4e094a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5714b4c12cbe5759149e6d4c161ddf7fa54b6ba04b002ee41b6caa1d966a20d10770d681d961d613d1187c96deec0dca5f382496721ce6fc62d75fc91284635d"} build_url:https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010969 build_url: 'https://queue.taskcluster.net/v1/task/UF03-rn_SGCSCi4tVBensA/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/aae8aaeea2590c1895bf8d71611e83bebab58020b39b2c72ea8ee2e95d3da8d1fd3fb8560af92a7b35c2167edcee916d3e91c7dd13b4bb8ac5d25e120ab98762", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/6827cb43793a3b6c60dc105825165d55087a6bfac0dfe3583265008c4f36e289edcda97721aa3820ec9688551b18379ccf3c22727efeb78582eee6b074172e4c", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/d25879632a44fc547c897605180c3987b745e1da8c39b0da6f25d9bb1f272d841dc95c00100c85e1fa528e0264c98660daef6724c57b715dfe500cb41d4e094a", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/5714b4c12cbe5759149e6d4c161ddf7fa54b6ba04b002ee41b6caa1d966a20d10770d681d961d613d1187c96deec0dca5f382496721ce6fc62d75fc91284635d"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-04-20 05:36:46.006855) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 05:36:46.007588) ========= 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.k8ui64L1JJ/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.NrYg77tQQh/Listeners TMPDIR=/var/folders/s7/5fc64b65217gh236xtt4c1sr00000w/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.005228 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-04-20 05:36:46.057556) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 05:36:46.057903) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-04-20 05:36:46.058230) ========= ========= Total master_lag: 0.19 =========