builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0368 starttime: 1485432352.66 results: success (0) buildid: 20170126033131 builduid: 3832566940ab4cc88edd6d6d35f022e0 revision: 1e036cc4bf25338708b1466a4756316390557241 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:52.661828) ========= master: http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:52.662333) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:52.662642) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:52.809447) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:52.809729) ========= 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.fVyLEeaxpo/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.Gao65OeplW/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False --2017-01-26 04:05:52-- 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% 18.9M=0.001s 2017-01-26 04:05:53 (18.9 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.607335 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:53.448724) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:53.449031) ========= 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.fVyLEeaxpo/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.Gao65OeplW/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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.019853 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:53.500861) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-26 04:05:53.501164) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 1e036cc4bf25338708b1466a4756316390557241 --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 1e036cc4bf25338708b1466a4756316390557241 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.fVyLEeaxpo/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.Gao65OeplW/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 2017-01-26 04:05:53,473 truncating revision to first 12 chars 2017-01-26 04:05:53,474 Setting DEBUG logging. 2017-01-26 04:05:53,474 attempt 1/10 2017-01-26 04:05:53,474 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/1e036cc4bf25?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-01-26 04:05:54,712 unpacking tar archive at: mozilla-central-1e036cc4bf25/testing/mozharness/ program finished with exit code 0 elapsedTime=1.510493 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-01-26 04:05:55.037383) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:55.040683) ========= script_repo_revision: 1e036cc4bf25338708b1466a4756316390557241 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:55.041049) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:55.041305) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-01-26 04:05:55.060987) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-26 04:05:55.061261) ========= /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.fVyLEeaxpo/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.Gao65OeplW/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/ TWISTD_LOG_PATH=/builds/slave/twistd.log USER=cltbld VERSIONER_PYTHON_PREFER_32_BIT=no VERSIONER_PYTHON_VERSION=2.7 XPCOM_DEBUG_BREAK=warn XPC_FLAGS=0x0 XPC_SERVICE_NAME=0 __CF_USER_TEXT_ENCODING=0x1C:0:0 using PTY: False 04:05:55 INFO - MultiFileLogger online at 20170126 04:05:55 in /builds/slave/test 04:05:55 INFO - Run as scripts/scripts/talos_script.py --suite dromaeojs --add-option --webServer,localhost --branch-name Firefox --cfg talos/mac_config.py --download-symbols ondemand --use-talos-json --blob-upload-branch Firefox 04:05:55 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:05:55 INFO - {'append_to_log': False, 04:05:55 INFO - 'base_work_dir': '/builds/slave/test', 04:05:55 INFO - 'blob_upload_branch': 'Firefox', 04:05:55 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:05:55 INFO - 'branch': 'Firefox', 04:05:55 INFO - 'buildbot_json_path': 'buildprops.json', 04:05:55 INFO - 'config_files': ('talos/mac_config.py',), 04:05:55 INFO - 'default_actions': ('clobber', 04:05:55 INFO - 'read-buildbot-config', 04:05:55 INFO - 'download-and-extract', 04:05:55 INFO - 'populate-webroot', 04:05:55 INFO - 'create-virtualenv', 04:05:55 INFO - 'install', 04:05:55 INFO - 'run-tests'), 04:05:55 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:05:55 INFO - 'download_minidump_stackwalk': True, 04:05:55 INFO - 'download_symbols': 'ondemand', 04:05:55 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:05:55 INFO - 'tooltool.py': '/tools/tooltool.py', 04:05:55 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:05:55 INFO - '/tools/misc-python/virtualenv.py')}, 04:05:55 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:05:55 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:05:55 INFO - 'installer_path': 'installer.exe', 04:05:55 INFO - 'log_level': 'info', 04:05:55 INFO - 'log_name': 'talos', 04:05:55 INFO - 'log_to_console': True, 04:05:55 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:05:55 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:05:55 INFO - 'opt_config_files': (), 04:05:55 INFO - 'pip_index': False, 04:05:55 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:05:55 INFO - 'cmd': ('bash', 04:05:55 INFO - '-c', 04:05:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:05:55 INFO - 'enabled': True, 04:05:55 INFO - 'halt_on_failure': False, 04:05:55 INFO - 'name': 'check_screen_resolution'},), 04:05:55 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:05:55 INFO - 'cmd': ('bash', 04:05:55 INFO - '-c', 04:05:55 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:05:55 INFO - 'enabled': True, 04:05:55 INFO - 'halt_on_failure': False, 04:05:55 INFO - 'name': 'check_screen_resolution'},), 04:05:55 INFO - 'run_cmd_checks_enabled': True, 04:05:55 INFO - 'sps_profile': False, 04:05:55 INFO - 'sps_profile_interval': 0, 04:05:55 INFO - 'suite': 'dromaeojs', 04:05:55 INFO - 'system_bits': '32', 04:05:55 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:05:55 INFO - 'title': 't-yosemite-r7-0368', 04:05:55 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:05:55 INFO - 'use_talos_json': True, 04:05:55 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:05:55 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:05:55 INFO - 'work_dir': 'build'} 04:05:55 INFO - [mozharness: 2017-01-26 12:05:55.147413Z] Running clobber step. 04:05:55 INFO - Running pre-action listener: _resource_record_pre_action 04:05:55 INFO - Running main action method: clobber 04:05:55 INFO - rmtree: /builds/slave/test/build 04:05:55 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:05:56 INFO - Running post-action listener: _resource_record_post_action 04:05:56 INFO - [mozharness: 2017-01-26 12:05:56.852247Z] Finished clobber step (success) 04:05:56 INFO - [mozharness: 2017-01-26 12:05:56.852376Z] Running read-buildbot-config step. 04:05:56 INFO - Running pre-action listener: _resource_record_pre_action 04:05:56 INFO - Running main action method: read_buildbot_config 04:05:56 INFO - Using buildbot properties: 04:05:56 INFO - { 04:05:56 INFO - "project": "", 04:05:56 INFO - "product": "firefox", 04:05:56 INFO - "script_repo_revision": "production", 04:05:56 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:05:56 INFO - "repository": "", 04:05:56 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:05:56 INFO - "buildid": "20170126033131", 04:05:56 INFO - "pgo_build": "False", 04:05:56 INFO - "basedir": "/builds/slave/test", 04:05:56 INFO - "buildnumber": 54, 04:05:56 INFO - "slavename": "t-yosemite-r7-0368", 04:05:56 INFO - "master": "http://buildbot-master133.bb.releng.scl3.mozilla.com:8201/", 04:05:56 INFO - "platform": "yosemite_r7", 04:05:56 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:05:56 INFO - "branch": "mozilla-central", 04:05:56 INFO - "repo_path": "mozilla-central", 04:05:56 INFO - "revision": "1e036cc4bf25338708b1466a4756316390557241", 04:05:56 INFO - "stage_platform": "macosx64", 04:05:56 INFO - "builduid": "3832566940ab4cc88edd6d6d35f022e0", 04:05:56 INFO - "slavebuilddir": "test" 04:05:56 INFO - } 04:05:56 INFO - Found installer url https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg. 04:05:56 INFO - Running post-action listener: _resource_record_post_action 04:05:56 INFO - [mozharness: 2017-01-26 12:05:56.855543Z] Finished read-buildbot-config step (success) 04:05:56 INFO - [mozharness: 2017-01-26 12:05:56.855628Z] Running download-and-extract step. 04:05:56 INFO - Running pre-action listener: _resource_record_pre_action 04:05:56 INFO - Running main action method: download_and_extract 04:05:56 INFO - mkdir: /builds/slave/test/build/tests 04:05:56 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:05:56 INFO - trying https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json 04:05:56 INFO - Downloading https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:05:56 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json'}, attempt #1 04:05:57 INFO - Downloaded 1199 bytes. 04:05:57 INFO - Reading from file /builds/slave/test/build/firefox-54.0a1.en-US.mac.test_packages.json 04:05:57 INFO - Using the following test package requirements: 04:05:57 INFO - {u'common': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:05:57 INFO - u'cppunittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:05:57 INFO - u'firefox-54.0a1.en-US.mac.cppunittest.tests.zip'], 04:05:57 INFO - u'gtest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:05:57 INFO - u'firefox-54.0a1.en-US.mac.gtest.tests.zip'], 04:05:57 INFO - u'jittest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:05:57 INFO - u'jsshell-mac.zip'], 04:05:57 INFO - u'mochitest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:05:57 INFO - u'firefox-54.0a1.en-US.mac.mochitest.tests.zip'], 04:05:57 INFO - u'mozbase': [u'firefox-54.0a1.en-US.mac.common.tests.zip'], 04:05:57 INFO - u'reftest': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:05:57 INFO - u'firefox-54.0a1.en-US.mac.reftest.tests.zip'], 04:05:57 INFO - u'talos': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:05:57 INFO - u'firefox-54.0a1.en-US.mac.talos.tests.zip'], 04:05:57 INFO - u'web-platform': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:05:57 INFO - u'firefox-54.0a1.en-US.mac.web-platform.tests.zip'], 04:05:57 INFO - u'xpcshell': [u'firefox-54.0a1.en-US.mac.common.tests.zip', 04:05:57 INFO - u'firefox-54.0a1.en-US.mac.xpcshell.tests.zip']} 04:05:57 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:05:57 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:05:57 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:05:57 INFO - Fetch https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:05:58 INFO - Expected file size: 16351810 04:05:58 INFO - Obtained file size: 16351810 04:06:05 INFO - Downloading packages: [u'firefox-54.0a1.en-US.mac.common.tests.zip', u'firefox-54.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:06:05 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip 04:06:05 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:06:05 INFO - Fetch https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.common.tests.zip into memory 04:06:06 INFO - Expected file size: 16351810 04:06:06 INFO - Obtained file size: 16351810 04:06:12 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip 04:06:12 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:06:12 INFO - Fetch https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.talos.tests.zip into memory 04:06:14 INFO - Expected file size: 14403435 04:06:14 INFO - Obtained file size: 14403435 04:06:14 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:14 INFO - trying https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:06:14 INFO - Downloading https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg 04:06:14 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg'}, attempt #1 04:06:16 INFO - Downloaded 69884182 bytes. 04:06:16 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:06:16 INFO - mkdir: /builds/slave/test/properties 04:06:16 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:06:16 INFO - Writing to file /builds/slave/test/properties/build_url 04:06:16 INFO - Contents: 04:06:16 INFO - build_url:https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg 04:06:17 INFO - Running post-action listener: _resource_record_post_action 04:06:17 INFO - Running post-action listener: set_extra_try_arguments 04:06:17 INFO - [mozharness: 2017-01-26 12:06:17.089358Z] Finished download-and-extract step (success) 04:06:17 INFO - [mozharness: 2017-01-26 12:06:17.089493Z] Running populate-webroot step. 04:06:17 INFO - Running pre-action listener: _resource_record_pre_action 04:06:17 INFO - Running main action method: populate_webroot 04:06:17 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:06:17 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:06:17 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:06:17 INFO - '--tppagecycles', 04:06:17 INFO - '7'], 04:06:17 INFO - 'tests': ['tsvgm']}}, 04:06:17 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:06:17 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:06:17 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:06:17 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:06:17 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:06:17 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:06:17 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:06:17 INFO - 'talos_options': ['--disable-e10s'], 04:06:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:17 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:06:17 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:06:17 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:06:17 INFO - 'talos_options': ['--disable-e10s'], 04:06:17 INFO - 'tests': ['damp', 'tps']}, 04:06:17 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:06:17 INFO - 'tests': ['damp', 'tps']}, 04:06:17 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:06:17 INFO - 'tests': ['dromaeo_dom']}, 04:06:17 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:06:17 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:06:17 INFO - 'tests': ['basic_compositor_video']}, 04:06:17 INFO - 'g4-e10s': {'tests': ['basic_compositor_video']}, 04:06:17 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:06:17 INFO - 'tests': ['a11yr', 04:06:17 INFO - 'ts_paint', 04:06:17 INFO - 'tpaint', 04:06:17 INFO - 'sessionrestore', 04:06:17 INFO - 'sessionrestore_no_auto_restore', 04:06:17 INFO - 'tabpaint']}, 04:06:17 INFO - 'other-e10s': {'tests': ['a11yr', 04:06:17 INFO - 'ts_paint', 04:06:17 INFO - 'tpaint', 04:06:17 INFO - 'sessionrestore', 04:06:17 INFO - 'sessionrestore_no_auto_restore', 04:06:17 INFO - 'tabpaint']}, 04:06:17 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:06:17 INFO - 'ts_paint', 04:06:17 INFO - 'tpaint', 04:06:17 INFO - 'sessionrestore', 04:06:17 INFO - 'sessionrestore_no_auto_restore', 04:06:17 INFO - 'tabpaint']}, 04:06:17 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:06:17 INFO - 'ts_paint', 04:06:17 INFO - 'tpaint', 04:06:17 INFO - 'sessionrestore', 04:06:17 INFO - 'sessionrestore_no_auto_restore', 04:06:17 INFO - 'tabpaint']}, 04:06:17 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:06:17 INFO - 'tests': ['a11yr', 04:06:17 INFO - 'ts_paint', 04:06:17 INFO - 'tpaint', 04:06:17 INFO - 'sessionrestore', 04:06:17 INFO - 'sessionrestore_no_auto_restore', 04:06:17 INFO - 'tabpaint']}, 04:06:17 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:06:17 INFO - 'tests': ['a11yr', 04:06:17 INFO - 'ts_paint', 04:06:17 INFO - 'tpaint', 04:06:17 INFO - 'sessionrestore', 04:06:17 INFO - 'sessionrestore_no_auto_restore', 04:06:17 INFO - 'tabpaint']}, 04:06:17 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:06:17 INFO - 'tests': ['tsvgx', 04:06:17 INFO - 'tsvgr_opacity', 04:06:17 INFO - 'tart', 04:06:17 INFO - 'tscrollx', 04:06:17 INFO - 'cart', 04:06:17 INFO - 'tsvg_static']}, 04:06:17 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:06:17 INFO - 'tsvgr_opacity', 04:06:17 INFO - 'tart', 04:06:17 INFO - 'tscrollx', 04:06:17 INFO - 'cart', 04:06:17 INFO - 'tsvg_static']}, 04:06:17 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:06:17 INFO - 'talos_options': ['--disable-e10s'], 04:06:17 INFO - 'tests': ['tp5o']}, 04:06:17 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:06:17 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:06:17 INFO - 'talos_options': ['--disable-e10s', 04:06:17 INFO - '--xperf_path', 04:06:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:17 INFO - 'tests': ['tp5n']}, 04:06:17 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:06:17 INFO - 'talos_options': ['--xperf_path', 04:06:17 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:06:17 INFO - 'tests': ['tp5n']}}, 04:06:17 INFO - 'talos.zip': {'path': '', 04:06:17 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:06:17 INFO - Running post-action listener: _resource_record_post_action 04:06:17 INFO - [mozharness: 2017-01-26 12:06:17.108151Z] Finished populate-webroot step (success) 04:06:17 INFO - [mozharness: 2017-01-26 12:06:17.108288Z] Running create-virtualenv step. 04:06:17 INFO - Running pre-action listener: _resource_record_pre_action 04:06:17 INFO - Running main action method: create_virtualenv 04:06:17 INFO - Creating virtualenv /builds/slave/test/build/venv 04:06:17 INFO - Running command: ['/tools/buildbot/bin/python', '/tools/misc-python/virtualenv.py', '--no-site-packages', '--distribute', '/builds/slave/test/build/venv'] in /builds/slave/test/build 04:06:17 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:06:17 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:06:17 INFO - Using real prefix '/tools/python27' 04:06:17 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:06:17 INFO - Installing distribute.............................................................................................................................................................................................done. 04:06:20 INFO - Installing pip.................done. 04:06:20 INFO - Return code: 0 04:06:20 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:06:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:06:21 INFO - Reading from file tmpfile_stdout 04:06:21 INFO - Output received: 04:06:21 INFO - pip 1.5.5 from /builds/slave/test/build/venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg (python 2.7) 04:06:21 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:21 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 0x106a74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb7acaba90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106852d30>, '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 0x106779db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106847be8>, '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.fVyLEeaxpo/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.Gao65OeplW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'pip>=1.5'] in /builds/slave/test/build 04:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub pip>=1.5 04:06:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fVyLEeaxpo/Render', 04:06:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:21 INFO - 'HOME': '/Users/cltbld', 04:06:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:21 INFO - 'LOGNAME': 'cltbld', 04:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:21 INFO - 'MOZ_NO_REMOTE': '1', 04:06:21 INFO - 'NO_EM_RESTART': '1', 04:06:21 INFO - 'PAGER': '/bin/cat', 04:06:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:21 INFO - 'PWD': '/builds/slave/test', 04:06:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:21 INFO - 'SHELL': '/bin/bash', 04:06:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gao65OeplW/Listeners', 04:06:21 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 04:06:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:21 INFO - 'USER': 'cltbld', 04:06:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:21 INFO - 'XPC_FLAGS': '0x0', 04:06:21 INFO - 'XPC_SERVICE_NAME': '0', 04:06:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:21 INFO - Requirement already satisfied (use --upgrade to upgrade): pip>=1.5 in ./venv/lib/python2.7/site-packages/pip-1.5.5-py2.7.egg 04:06:21 INFO - Cleaning up... 04:06:21 INFO - Return code: 0 04:06:21 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:21 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:21 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:21 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:21 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:21 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 0x106a74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb7acaba90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106852d30>, '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 0x106779db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106847be8>, '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.fVyLEeaxpo/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.Gao65OeplW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:21 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'psutil>=3.1.1'] in /builds/slave/test/build 04:06:21 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub psutil>=3.1.1 04:06:21 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fVyLEeaxpo/Render', 04:06:21 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:21 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:21 INFO - 'HOME': '/Users/cltbld', 04:06:21 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:21 INFO - 'LOGNAME': 'cltbld', 04:06:21 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:21 INFO - 'MOZ_NO_REMOTE': '1', 04:06:21 INFO - 'NO_EM_RESTART': '1', 04:06:21 INFO - 'PAGER': '/bin/cat', 04:06:21 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:21 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:21 INFO - 'PWD': '/builds/slave/test', 04:06:21 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:21 INFO - 'SHELL': '/bin/bash', 04:06:21 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gao65OeplW/Listeners', 04:06:21 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 04:06:21 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:21 INFO - 'USER': 'cltbld', 04:06:21 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:21 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:21 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:21 INFO - 'XPC_FLAGS': '0x0', 04:06:21 INFO - 'XPC_SERVICE_NAME': '0', 04:06:21 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:21 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:21 INFO - Downloading/unpacking psutil>=3.1.1 04:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:21 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:21 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:21 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:21 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:25 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:06:25 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:25 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:25 INFO - Installing collected packages: psutil 04:06:25 INFO - Running setup.py install for psutil 04:06:25 INFO - building 'psutil._psutil_osx' extension 04:06:25 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_osx.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o 04:06:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/_psutil_common.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o 04:06:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -DPSUTIL_VERSION=311 -I/tools/python27/include/python2.7 -c psutil/arch/osx/process_info.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o 04:06:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_common.o build/temp.macosx-10.10-x86_64-2.7/psutil/arch/osx/process_info.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_osx.so -framework CoreFoundation -framework IOKit 04:06:26 INFO - building 'psutil._psutil_posix' extension 04:06:26 INFO - gcc -fno-strict-aliasing -g -O2 -DNDEBUG -g -fwrapv -O3 -Wall -Wstrict-prototypes -I/tools/python27/include/python2.7 -c psutil/_psutil_posix.c -o build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o 04:06:26 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:06:26 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:06:26 INFO - ^ 04:06:26 INFO - 1 warning generated. 04:06:26 INFO - gcc -bundle -bundle_loader /tools/python27/bin/python2.7 build/temp.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.o -o build/lib.macosx-10.10-x86_64-2.7/psutil/_psutil_posix.so 04:06:26 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:06:26 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:06:26 INFO - Successfully installed psutil 04:06:26 INFO - Cleaning up... 04:06:26 INFO - Return code: 0 04:06:26 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:06: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')]} 04:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:26 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06: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')]} 04:06:26 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:26 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:26 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 0x106a74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb7acaba90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106852d30>, '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 0x106779db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106847be8>, '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.fVyLEeaxpo/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.Gao65OeplW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:26 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 04:06:26 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub mozsystemmonitor==0.3 04:06:26 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fVyLEeaxpo/Render', 04:06:26 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:26 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:26 INFO - 'HOME': '/Users/cltbld', 04:06:26 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:26 INFO - 'LOGNAME': 'cltbld', 04:06:26 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:26 INFO - 'MOZ_NO_REMOTE': '1', 04:06:26 INFO - 'NO_EM_RESTART': '1', 04:06:26 INFO - 'PAGER': '/bin/cat', 04:06:26 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:26 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:26 INFO - 'PWD': '/builds/slave/test', 04:06:26 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:26 INFO - 'SHELL': '/bin/bash', 04:06:26 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gao65OeplW/Listeners', 04:06:26 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 04:06:26 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:26 INFO - 'USER': 'cltbld', 04:06:26 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:26 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:26 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:26 INFO - 'XPC_FLAGS': '0x0', 04:06:26 INFO - 'XPC_SERVICE_NAME': '0', 04:06:26 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:26 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:26 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:26 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:26 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:26 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:26 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:29 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:06:29 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:06:29 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:06:29 INFO - Installing collected packages: mozsystemmonitor 04:06:29 INFO - Running setup.py install for mozsystemmonitor 04:06:29 INFO - Successfully installed mozsystemmonitor 04:06:29 INFO - Cleaning up... 04:06:29 INFO - Return code: 0 04:06:29 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:29 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:29 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:29 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:29 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:29 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106a74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb7acaba90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106852d30>, '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 0x106779db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106847be8>, '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.fVyLEeaxpo/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.Gao65OeplW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:29 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:06:29 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:06:29 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fVyLEeaxpo/Render', 04:06:29 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:29 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:29 INFO - 'HOME': '/Users/cltbld', 04:06:29 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:29 INFO - 'LOGNAME': 'cltbld', 04:06:29 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:29 INFO - 'MOZ_NO_REMOTE': '1', 04:06:29 INFO - 'NO_EM_RESTART': '1', 04:06:29 INFO - 'PAGER': '/bin/cat', 04:06:29 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:29 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:29 INFO - 'PWD': '/builds/slave/test', 04:06:29 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:29 INFO - 'SHELL': '/bin/bash', 04:06:29 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gao65OeplW/Listeners', 04:06:29 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 04:06:29 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:29 INFO - 'USER': 'cltbld', 04:06:29 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:29 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:29 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:29 INFO - 'XPC_FLAGS': '0x0', 04:06:29 INFO - 'XPC_SERVICE_NAME': '0', 04:06:29 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:30 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:30 INFO - Downloading/unpacking jsonschema==2.5.1 04:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:30 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:30 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:30 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:30 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:32 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:06:32 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:32 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:32 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:32 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:32 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:33 INFO - Downloading functools32-3.2.3-2.tar.gz 04:06:33 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:06:33 INFO - warning: no files found matching '*.txt' 04:06:33 INFO - no previously-included directories found matching 'build' 04:06:33 INFO - no previously-included directories found matching 'dist' 04:06:33 INFO - no previously-included directories found matching '.git*' 04:06:33 INFO - Installing collected packages: jsonschema, functools32 04:06:33 INFO - Running setup.py install for functools32 04:06:33 INFO - warning: no files found matching '*.txt' 04:06:33 INFO - no previously-included directories found matching 'build' 04:06:33 INFO - no previously-included directories found matching 'dist' 04:06:33 INFO - no previously-included directories found matching '.git*' 04:06:33 INFO - Successfully installed jsonschema functools32 04:06:33 INFO - Cleaning up... 04:06:33 INFO - Return code: 0 04:06:33 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:33 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 0x106a74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb7acaba90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106852d30>, '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 0x106779db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106847be8>, '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.fVyLEeaxpo/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.Gao65OeplW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:06:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fVyLEeaxpo/Render', 04:06:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:33 INFO - 'HOME': '/Users/cltbld', 04:06:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:33 INFO - 'LOGNAME': 'cltbld', 04:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:33 INFO - 'MOZ_NO_REMOTE': '1', 04:06:33 INFO - 'NO_EM_RESTART': '1', 04:06:33 INFO - 'PAGER': '/bin/cat', 04:06:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:33 INFO - 'PWD': '/builds/slave/test', 04:06:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:33 INFO - 'SHELL': '/bin/bash', 04:06:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gao65OeplW/Listeners', 04:06:33 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 04:06:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:33 INFO - 'USER': 'cltbld', 04:06:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:33 INFO - 'XPC_FLAGS': '0x0', 04:06:33 INFO - 'XPC_SERVICE_NAME': '0', 04:06:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:33 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:33 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:06:33 INFO - Cleaning up... 04:06:33 INFO - Return code: 0 04:06:33 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:33 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:33 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:33 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:33 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:33 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:33 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 0x106a74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb7acaba90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106852d30>, '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 0x106779db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106847be8>, '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.fVyLEeaxpo/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.Gao65OeplW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:33 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:06:33 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:06:33 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fVyLEeaxpo/Render', 04:06:33 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:33 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:33 INFO - 'HOME': '/Users/cltbld', 04:06:33 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:33 INFO - 'LOGNAME': 'cltbld', 04:06:33 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:33 INFO - 'MOZ_NO_REMOTE': '1', 04:06:33 INFO - 'NO_EM_RESTART': '1', 04:06:33 INFO - 'PAGER': '/bin/cat', 04:06:33 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:33 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:33 INFO - 'PWD': '/builds/slave/test', 04:06:33 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:33 INFO - 'SHELL': '/bin/bash', 04:06:33 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gao65OeplW/Listeners', 04:06:33 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 04:06:33 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:33 INFO - 'USER': 'cltbld', 04:06:33 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:33 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:33 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:33 INFO - 'XPC_FLAGS': '0x0', 04:06:33 INFO - 'XPC_SERVICE_NAME': '0', 04:06:33 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:34 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:34 INFO - Downloading/unpacking blobuploader==1.2.4 04:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:34 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:34 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:34 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:34 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:36 INFO - Downloading blobuploader-1.2.4.tar.gz 04:06:36 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:06:36 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06: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 04:06:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:06:37 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:37 INFO - Downloading docopt-0.6.1.tar.gz 04:06:37 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:06:38 INFO - Installing collected packages: blobuploader, requests, docopt 04:06:38 INFO - Running setup.py install for blobuploader 04:06:38 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:06:38 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:06:38 INFO - Running setup.py install for requests 04:06:38 INFO - Running setup.py install for docopt 04:06:38 INFO - Successfully installed blobuploader requests docopt 04:06:38 INFO - Cleaning up... 04:06:38 INFO - Return code: 0 04:06:38 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:38 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:38 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 0x106a74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb7acaba90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106852d30>, '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 0x106779db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106847be8>, '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.fVyLEeaxpo/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.Gao65OeplW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--no-deps', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:06:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --no-deps --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:06:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fVyLEeaxpo/Render', 04:06:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:38 INFO - 'HOME': '/Users/cltbld', 04:06:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:38 INFO - 'LOGNAME': 'cltbld', 04:06:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:38 INFO - 'MOZ_NO_REMOTE': '1', 04:06:38 INFO - 'NO_EM_RESTART': '1', 04:06:38 INFO - 'PAGER': '/bin/cat', 04:06:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:38 INFO - 'PWD': '/builds/slave/test', 04:06:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:38 INFO - 'SHELL': '/bin/bash', 04:06:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gao65OeplW/Listeners', 04:06:38 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 04:06:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:38 INFO - 'USER': 'cltbld', 04:06:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:38 INFO - 'XPC_FLAGS': '0x0', 04:06:38 INFO - 'XPC_SERVICE_NAME': '0', 04:06:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:39 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:39 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-5VeL9u-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:39 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-DpYvcI-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:39 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-7pFcRX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:39 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-CD3_Wi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:39 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-noSngz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:39 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-ibDqSC-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:39 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-aFpdVE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:39 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:39 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-mASqNA-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:40 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-o511J_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:40 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-hQMVum-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:40 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-2UidjL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:40 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-tcrjKi-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:40 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-z7yzGv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:40 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-l4KgQG-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:40 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-hLAaAb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:40 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-_jhLLl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:40 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:40 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-aC56sb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:41 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:06:41 INFO - Running setup.py install for manifestparser 04:06:41 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:06:41 INFO - Running setup.py install for mozcrash 04:06:41 INFO - Running setup.py install for mozdebug 04:06:41 INFO - Running setup.py install for mozdevice 04:06:41 INFO - Installing sutini script to /builds/slave/test/build/venv/bin 04:06:41 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:06:41 INFO - Running setup.py install for mozfile 04:06:41 INFO - Running setup.py install for mozhttpd 04:06:41 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:06:41 INFO - Running setup.py install for mozinfo 04:06:42 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:06:42 INFO - Running setup.py install for mozInstall 04:06:42 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:06:42 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:06:42 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:06:42 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:06:42 INFO - Running setup.py install for mozleak 04:06:42 INFO - Running setup.py install for mozlog 04:06:42 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:06:42 INFO - Running setup.py install for moznetwork 04:06:42 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:06:42 INFO - Running setup.py install for mozprocess 04:06:42 INFO - Running setup.py install for mozprofile 04:06:42 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:06:42 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:06:42 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:06:42 INFO - Running setup.py install for mozrunner 04:06:43 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:06:43 INFO - Running setup.py install for mozscreenshot 04:06:43 INFO - Running setup.py install for moztest 04:06:43 INFO - Running setup.py install for mozversion 04:06:43 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:06:43 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:06:43 INFO - Cleaning up... 04:06:43 INFO - Return code: 0 04:06:43 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:43 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:43 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:43 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:43 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 0x106a74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb7acaba90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106852d30>, '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 0x106779db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106847be8>, '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.fVyLEeaxpo/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.Gao65OeplW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:43 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/config/mozbase_requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/config 04:06:43 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/config/mozbase_requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:06:43 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fVyLEeaxpo/Render', 04:06:43 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:43 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:43 INFO - 'HOME': '/Users/cltbld', 04:06:43 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:43 INFO - 'LOGNAME': 'cltbld', 04:06:43 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:43 INFO - 'MOZ_NO_REMOTE': '1', 04:06:43 INFO - 'NO_EM_RESTART': '1', 04:06:43 INFO - 'PAGER': '/bin/cat', 04:06:43 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:43 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:43 INFO - 'PWD': '/builds/slave/test', 04:06:43 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:43 INFO - 'SHELL': '/bin/bash', 04:06:43 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gao65OeplW/Listeners', 04:06:43 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 04:06:43 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:43 INFO - 'USER': 'cltbld', 04:06:43 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:43 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:43 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:43 INFO - 'XPC_FLAGS': '0x0', 04:06:43 INFO - 'XPC_SERVICE_NAME': '0', 04:06:43 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:43 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:06:43 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-jjUSQ4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:06:43 INFO - Requirement already satisfied (use --upgrade to upgrade): manifestparser==1.1 from file:///builds/slave/test/build/tests/mozbase/manifestparser in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 1)) 04:06:43 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:06:43 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-MJB3QZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash==1.0 from file:///builds/slave/test/build/tests/mozbase/mozcrash in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:06:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-DvSApZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdebug==0.1 from file:///builds/slave/test/build/tests/mozbase/mozdebug in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:06:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-x6Zwnk-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.49 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:06:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-G64xDZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile==1.2 from file:///builds/slave/test/build/tests/mozbase/mozfile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 5)) 04:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:06:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-cknXYo-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd==0.7 from file:///builds/slave/test/build/tests/mozbase/mozhttpd in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 6)) 04:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:06:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-yNT1ui-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo==0.9 from file:///builds/slave/test/build/tests/mozbase/mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 7)) 04:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:06:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-FXJauW-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozInstall==1.12 from file:///builds/slave/test/build/tests/mozbase/mozinstall in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 8)) 04:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:06:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-vgUtjE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozleak==0.1 from file:///builds/slave/test/build/tests/mozbase/mozleak in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 9)) 04:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:06:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-wwYKBq-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:06:44 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog==3.4 from file:///builds/slave/test/build/tests/mozbase/mozlog in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:06:44 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-7cTJ8C-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork==0.27 from file:///builds/slave/test/build/tests/mozbase/moznetwork in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 11)) 04:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:06:45 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-L1ilm0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.24 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:06:45 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-mB6wkl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile==0.28 from file:///builds/slave/test/build/tests/mozbase/mozprofile in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 13)) 04:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:06:45 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-wGawGb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozrunner==6.13 from file:///builds/slave/test/build/tests/mozbase/mozrunner in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 14)) 04:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:45 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-zmt2Lx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozscreenshot==0.1 from file:///builds/slave/test/build/tests/mozbase/mozscreenshot in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 15)) 04:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:06:45 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-AsQxVx-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moztest==0.8 from file:///builds/slave/test/build/tests/mozbase/moztest in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 16)) 04:06:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:06:45 INFO - Running setup.py (path:/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/pip-kDGFbz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion==1.4 from file:///builds/slave/test/build/tests/mozbase/mozversion in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 17)) 04:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.0 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozcrash==1.0->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 2)) 04:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdebug==0.1->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 3)) 04:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:45 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.49->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:06:45 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:45 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:45 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:06:45 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:06:45 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:06:48 INFO - Downloading blessings-1.6.tar.gz 04:06:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:06:48 INFO - Installing collected packages: blessings 04:06:48 INFO - Running setup.py install for blessings 04:06:48 INFO - Successfully installed blessings 04:06:48 INFO - Cleaning up... 04:06:48 INFO - Return code: 0 04:06:48 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:06:48 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:48 INFO - Reading from file tmpfile_stdout 04:06:48 INFO - Current package versions: 04:06:48 INFO - blessings == 1.6 04:06:48 INFO - blobuploader == 1.2.4 04:06:48 INFO - docopt == 0.6.1 04:06:48 INFO - functools32 == 3.2.3-2 04:06:48 INFO - jsonschema == 2.5.1 04:06:48 INFO - manifestparser == 1.1 04:06:48 INFO - mozInstall == 1.12 04:06:48 INFO - mozcrash == 1.0 04:06:48 INFO - mozdebug == 0.1 04:06:48 INFO - mozdevice == 0.49 04:06:48 INFO - mozfile == 1.2 04:06:48 INFO - mozhttpd == 0.7 04:06:48 INFO - mozinfo == 0.9 04:06:48 INFO - mozleak == 0.1 04:06:48 INFO - mozlog == 3.4 04:06:48 INFO - moznetwork == 0.27 04:06:48 INFO - mozprocess == 0.24 04:06:48 INFO - mozprofile == 0.28 04:06:48 INFO - mozrunner == 6.13 04:06:48 INFO - mozscreenshot == 0.1 04:06:48 INFO - mozsystemmonitor == 0.3 04:06:48 INFO - moztest == 0.8 04:06:48 INFO - mozversion == 1.4 04:06:48 INFO - psutil == 3.1.1 04:06:48 INFO - requests == 1.2.3 04:06:48 INFO - wsgiref == 0.1.2 04:06:48 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:48 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:48 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:48 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:48 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:48 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:48 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 0x106a74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb7acaba90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106852d30>, '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 0x106779db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106847be8>, '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.fVyLEeaxpo/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.Gao65OeplW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:48 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '-r', '/builds/slave/test/build/tests/talos/requirements.txt', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub'] in /builds/slave/test/build/tests/talos 04:06:48 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 -r /builds/slave/test/build/tests/talos/requirements.txt --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub 04:06:48 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fVyLEeaxpo/Render', 04:06:48 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:48 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:48 INFO - 'HOME': '/Users/cltbld', 04:06:48 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:48 INFO - 'LOGNAME': 'cltbld', 04:06:48 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:48 INFO - 'MOZ_NO_REMOTE': '1', 04:06:48 INFO - 'NO_EM_RESTART': '1', 04:06:48 INFO - 'PAGER': '/bin/cat', 04:06:48 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:48 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:48 INFO - 'PWD': '/builds/slave/test', 04:06:48 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:48 INFO - 'SHELL': '/bin/bash', 04:06:48 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gao65OeplW/Listeners', 04:06:48 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 04:06:48 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:48 INFO - 'USER': 'cltbld', 04:06:48 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:48 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:48 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:48 INFO - 'XPC_FLAGS': '0x0', 04:06:48 INFO - 'XPC_SERVICE_NAME': '0', 04:06:48 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozlog>=3.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozcrash>=0.15 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 2)) 04:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozfile>=1.2 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 3)) 04:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozhttpd>=0.7 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozinfo>=0.8 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 5)) 04:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.22 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 6)) 04:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozversion>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 7)) 04:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprofile>=0.25 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 8)) 04:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/talos/requirements.txt (line 9)) 04:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): blessings>=1.3 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozlog>=3.1->-r /builds/slave/test/build/tests/talos/requirements.txt (line 1)) 04:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozhttpd>=0.7->-r /builds/slave/test/build/tests/talos/requirements.txt (line 4)) 04:06:49 INFO - Cleaning up... 04:06:49 INFO - Return code: 0 04:06:49 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:06:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:49 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:06:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:06:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:06:49 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x106a74b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106a77768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7feb7acaba90>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x106852d30>, '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 0x106779db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106847be8>, '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.fVyLEeaxpo/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.Gao65OeplW/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', '__CF_USER_TEXT_ENCODING': '0x1C:0:0', 'PWD': '/builds/slave/test', 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 'MOZ_CRASHREPORTER_NO_REPORT': '1', 'PAGER': '/bin/cat'}}, attempt #1 04:06:49 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema'] in /builds/slave/test/build 04:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema 04:06:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fVyLEeaxpo/Render', 04:06:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:06:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:06:49 INFO - 'HOME': '/Users/cltbld', 04:06:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:06:49 INFO - 'LOGNAME': 'cltbld', 04:06:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:06:49 INFO - 'MOZ_NO_REMOTE': '1', 04:06:49 INFO - 'NO_EM_RESTART': '1', 04:06:49 INFO - 'PAGER': '/bin/cat', 04:06:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:06:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:06:49 INFO - 'PWD': '/builds/slave/test', 04:06:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:06:49 INFO - 'SHELL': '/bin/bash', 04:06:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gao65OeplW/Listeners', 04:06:49 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 04:06:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:06:49 INFO - 'USER': 'cltbld', 04:06:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:06:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:06:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:06:49 INFO - 'XPC_FLAGS': '0x0', 04:06:49 INFO - 'XPC_SERVICE_NAME': '0', 04:06:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:06:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:06:49 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:06:49 INFO - Cleaning up... 04:06:49 INFO - Return code: 0 04:06:49 INFO - Running post-action listener: _resource_record_post_action 04:06:49 INFO - Running post-action listener: _start_resource_monitoring 04:06:49 INFO - Starting resource monitoring. 04:06:49 INFO - [mozharness: 2017-01-26 12:06:49.511176Z] Finished create-virtualenv step (success) 04:06:49 INFO - [mozharness: 2017-01-26 12:06:49.512190Z] Running install step. 04:06:49 INFO - Running pre-action listener: _resource_record_pre_action 04:06:49 INFO - Running main action method: install 04:06:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:06:49 INFO - Reading from file tmpfile_stdout 04:06:49 INFO - Detecting whether we're running mozinstall >=1.0... 04:06:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:06:49 INFO - Reading from file tmpfile_stdout 04:06:49 INFO - Output received: 04:06:49 INFO - Usage: mozinstall [options] installer 04:06:49 INFO - Options: 04:06:49 INFO - -h, --help show this help message and exit 04:06:49 INFO - -d DEST, --destination=DEST 04:06:49 INFO - Directory to install application into. [default: 04:06:49 INFO - "/builds/slave/test"] 04:06:49 INFO - --app=APP Application being installed. [default: firefox] 04:06:49 INFO - mkdir: /builds/slave/test/build/application 04:06:49 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:06:49 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-54.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:07:11 INFO - Reading from file tmpfile_stdout 04:07:11 INFO - Output received: 04:07:11 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 04:07:11 INFO - Running post-action listener: _resource_record_post_action 04:07:11 INFO - [mozharness: 2017-01-26 12:07:11.658257Z] Finished install step (success) 04:07:11 INFO - [mozharness: 2017-01-26 12:07:11.658387Z] Running run-tests step. 04:07:11 INFO - Running pre-action listener: _resource_record_pre_action 04:07:11 INFO - Running main action method: run_tests 04:07:11 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:07:11 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:07:11 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:07:11 INFO - 2017-01-26 04:07:11.673 screenresolution[1932:18057] starting screenresolution argv=screenresolution get 04:07:11 INFO - 2017-01-26 04:07:11.675 screenresolution[1932:18057] Display 0: 1600x1200x32@60 04:07:11 INFO - 2017-01-26 04:07:11.681 screenresolution[1933:18059] starting screenresolution argv=screenresolution list 04:07:11 INFO - Available Modes on Display 0 04:07:11 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:07:11 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:07:11 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:07:11 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:07:11 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:07:11 INFO - Intel Iris: 04:07:11 INFO - Chipset Model: Intel Iris 04:07:11 INFO - Type: GPU 04:07:11 INFO - Bus: Built-In 04:07:11 INFO - VRAM (Dynamic, Max): 1536 MB 04:07:11 INFO - Vendor: Intel (0x8086) 04:07:11 INFO - Device ID: 0x0a2e 04:07:11 INFO - Revision ID: 0x0009 04:07:11 INFO - Displays: 04:07:11 INFO - Display: 04:07:11 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:07:11 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:07:11 INFO - Display Serial Number: 1600x1200 60 04:07:11 INFO - Main Display: Yes 04:07:11 INFO - Mirror: Off 04:07:11 INFO - Online: Yes 04:07:11 INFO - Rotation: Supported 04:07:11 INFO - Return code: 0 04:07:11 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:07:11 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:07:11 INFO - Python 2.7.3 04:07:11 INFO - Return code: 0 04:07:11 INFO - grabbing minidump binary from tooltool 04:07: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')]} 04:07:11 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 0x106852d30>, '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 0x106779db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x106847be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:07:11 INFO - Running command: ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] in /builds/slave/test/build 04:07:11 INFO - Copy/paste: /tools/tooltool.py --url https://api.pub.build.mozilla.org/tooltool/ --authentication-file /builds/relengapi.tok fetch -m /builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest -o -c /builds/tooltool_cache 04:07:11 INFO - Calling ['/tools/tooltool.py', '--url', 'https://api.pub.build.mozilla.org/tooltool/', '--authentication-file', '/builds/relengapi.tok', 'fetch', '-m', '/builds/slave/test/build/tests/config/tooltool-manifests/macosx64/releng.manifest', '-o', '-c', '/builds/tooltool_cache'] with output_timeout 600 04:07:11 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:07:12 INFO - Return code: 0 04:07:12 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:07:12 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:07:12 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:07:12 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:07:12 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:07:12 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0368', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] in /builds/slave/test/build 04:07:12 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0368 --webServer localhost --log-tbpl-level=debug --log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log --log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log 04:07:12 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.fVyLEeaxpo/Render', 04:07:12 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:07:12 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:07:12 INFO - 'HOME': '/Users/cltbld', 04:07:12 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:07:12 INFO - 'LOGNAME': 'cltbld', 04:07:12 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:07:12 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:07:12 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:07:12 INFO - 'MOZ_NO_REMOTE': '1', 04:07:12 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:07:12 INFO - 'NO_EM_RESTART': '1', 04:07:12 INFO - 'PAGER': '/bin/cat', 04:07:12 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:07:12 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:07:12 INFO - 'PWD': '/builds/slave/test', 04:07:12 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:07:12 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:07:12 INFO - 'SHELL': '/bin/bash', 04:07:12 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.Gao65OeplW/Listeners', 04:07:12 INFO - 'TMPDIR': '/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/', 04:07:12 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:07:12 INFO - 'USER': 'cltbld', 04:07:12 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:07:12 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:07:12 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:07:12 INFO - 'XPC_FLAGS': '0x0', 04:07:12 INFO - 'XPC_SERVICE_NAME': '0', 04:07:12 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:07:12 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0368', '--webServer', 'localhost', '--log-tbpl-level=debug', '--log-errorsummary=/builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log', '--log-raw=/builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log'] with output_timeout 3600 04:07:12 INFO - mozversion application_buildid: 20170126033131 04:07:12 INFO - mozversion application_changeset: 1e036cc4bf25338708b1466a4756316390557241 04:07:12 INFO - mozversion application_display_name: Nightly 04:07:12 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:07:12 INFO - mozversion application_name: Firefox 04:07:12 INFO - mozversion application_remotingname: firefox 04:07:12 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:07:12 INFO - mozversion application_vendor: Mozilla 04:07:12 INFO - mozversion application_version: 54.0a1 04:07:12 INFO - mozversion platform_buildid: 20170126033131 04:07:12 INFO - mozversion platform_changeset: 1e036cc4bf25338708b1466a4756316390557241 04:07:12 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:07:12 INFO - mozversion platform_version: 54.0a1 04:07:12 INFO - using testdate: 1485432432 04:07:12 INFO - actual date: 1485432432 04:07:12 INFO - starting webserver on 'localhost:53482' 04:07:12 INFO - SUITE-START | Running 2 tests 04:07:12 INFO - TEST-START | dromaeo_css 04:07:12 INFO - operating with platform_type : mac_ 04:07:12 INFO - Initialising browser for dromaeo_css test... 04:07:12 INFO - TEST-INFO | started process 1943 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/tmpOyXOx0/profile http://localhost:53482/getInfo.html) 04:07:14 INFO - PROCESS | 1943 | __metrics Screen width/height:1600/1200 04:07:14 INFO - PROCESS | 1943 | colorDepth:24 04:07:14 INFO - PROCESS | 1943 | Browser inner width/height: 1024/689 04:07:14 INFO - PROCESS | 1943 | __metrics 04:07:14 INFO - PROCESS | 1943 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:07:14 INFO - PROCESS | 1943 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:07:15 INFO - TEST-INFO | 1943: exit 0 04:07:15 INFO - Browser initialized. 04:07:15 INFO - Running cycle 1/1 for dromaeo_css test... 04:07:15 INFO - TEST-INFO | started process 1945 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/tmpOyXOx0/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:07:27 INFO - PROCESS | 1945 | RSS: Main: 228519936 04:07:27 INFO - PROCESS | 1945 | 04:10:30 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53482/tests/dromaeo/cssquery-dojo.html (next: http://localhost:53482/tests/dromaeo/cssquery-ext.html) 04:10:33 INFO - PROCESS | 1945 | RSS: Main: 348569600 04:10:33 INFO - PROCESS | 1945 | 04:12:17 INFO - PROCESS | 1945 | ************************* 04:12:17 INFO - PROCESS | 1945 | A coding exception was thrown and uncaught in a Task. 04:12:17 INFO - PROCESS | 1945 | 04:12:17 ERROR - PROCESS | 1945 | Full message: TypeError: NetworkError when attempting to fetch resource. 04:12:17 INFO - PROCESS | 1945 | Full stack: 04:12:17 INFO - PROCESS | 1945 | ************************* 04:13:36 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53482/tests/dromaeo/cssquery-ext.html (next: http://localhost:53482/tests/dromaeo/cssquery-jquery.html) 04:13:36 INFO - PROCESS | 1945 | RSS: Main: 482455552 04:13:36 INFO - PROCESS | 1945 | 04:16:39 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53482/tests/dromaeo/cssquery-jquery.html (next: http://localhost:53482/tests/dromaeo/cssquery-mootools.html) 04:16:40 INFO - PROCESS | 1945 | RSS: Main: 358883328 04:16:40 INFO - PROCESS | 1945 | 04:19:42 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53482/tests/dromaeo/cssquery-mootools.html (next: http://localhost:53482/tests/dromaeo/cssquery-prototype.html) 04:19:43 INFO - PROCESS | 1945 | RSS: Main: 359211008 04:19:43 INFO - PROCESS | 1945 | 04:22:46 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53482/tests/dromaeo/cssquery-prototype.html (next: http://localhost:53482/tests/dromaeo/cssquery-yui.html) 04:22:47 INFO - PROCESS | 1945 | RSS: Main: 325054464 04:22:47 INFO - PROCESS | 1945 | 04:25:50 INFO - PROCESS | 1945 | Cycle 1(1): loaded http://localhost:53482/tests/dromaeo/cssquery-yui.html (next: http://localhost:53482/tests/dromaeo/cssquery-dojo.html) 04:25:50 INFO - PROCESS | 1945 | RSS: Main: 416641024 04:25:50 INFO - PROCESS | 1945 | 04:25:50 INFO - PROCESS | 1945 | __start_tp_report 04:25:50 INFO - PROCESS | 1945 | _x_x_mozilla_page_load 04:25:50 INFO - PROCESS | 1945 | _x_x_mozilla_page_load_details 04:25:50 INFO - PROCESS | 1945 | |i|pagename|runs| 04:25:50 INFO - PROCESS | 1945 | |0;dojo.html;2715.769159621432;3271.0513950954223;3294.489354150107;3308.2887179256454;3343.7826541274817;5419.756110975006;5453.64551304165;5506.366767821702;5550.91673624896;5561.388247292794;5495.395506494282;5512.586556008306;5578.525825304844;5579.246801681772;5614.522765564921;5016.623753218505;5025.572826309768;5056.696598204101;5071.391433028042;5115.002574497975;4156.646685031776;5187.273781670569;5205.141151709963;5209.244659524366;5251.684898906059;5038.017586570621;5154.252633368178;5160.225966105077;5184.662996905208;5211.895762084756;5061.873453163664;5092.185250359925;5115.514026167508;5130.871728206787;5140.845774626767;5059.569936555397;5102.979404119191;5110.5400513953555;5125.103106956268;5150.356205474316;5548.361938377098;5551.694656793875;5558.749856256478;5566.109422492423;5602.439756024406;5928.407159284037;5953.493953013999;5963;5963.4334738199805;6106.389361063858;6126.5176737973225;6133.285424838581;6177.2587289525545;6205.03821907605;6213.689315534205;5669.121286200645;5671.404502527258;5677.574181936371;5685;5731.856703582402;6134.1119512865025;6191.690415479208;6215.906761398583;6299.0866324382705;6304.211973503312;5867.970660146672;5871.236739223874;5914.792982245687;5988.011978023665;6009.639421634716;6006.909896351558;6139.447449729457;6152.661603611844;6157.138000679908;6168.383161683885;5872.765089396376;5912.083627037816;5957.255343082114;5991.370906054802;5992.910106348409;5951.970240148771;6016.428439298347;6018.548608854353;6027.21646185993;6036.939630603725;4620.052889157714;4871.853844384674;4878.780454879539;4914.655974081851;4926.064047830901;3657.2685462906993;4320.243957307459;4326.4808223012815;4328.458942632171;4350.195213885378;5620.971895140498;5671.602987790898;5684.062129748545;5698.715064246771;5739.053056245672;6149.41580549847;6155.353687862799;6173.629582225081;6174.950258456073;6185.8144255672405;4577.359169716243;5522.91715624266;5660.5471562274915;5671.291088613923;5688.914666280009;5304.045271851104;5310.787568497217;5311.814086506954;5319.46805319465;5330.466953304638;6250.499960003189;6302.621842689453;6322.209723784527;6324.557280990287;6325.778597749057;6152.907706384497;6199.876002480015;6215.844603884939;6218.973869311513;6236.314005459487;6127.816165515042;6135.294441139326;6258.280297765815;6300.401461861115;6302.275238347649;5983.102534619842;6014.669193194416;6021.307549631849;6102.580142287504;6103.761967187164;6089.706984989208;6139.246828488627;6159.661218632839;6182.907256391068;6211.316755156839;5718.085106382959;5919.378465261086;5998.970005149947;6000.729967151401;6024.3975602439405;5730.398308177748;5860.736266868086;5869.647821130575;5905.2913650360515;5980.34216236205;5657.066584013592;5696.544276457957;5810.448007439287;5814.680192589448;5824.184614153937;5836.299644042742;5882.088276317178;5890.087036509177;5911.467967882912;5918.141869428822;5728.342649122788;5819.650820950587;5822.388649191943;5833.562482813721;5849.034909240098 04:25:50 INFO - PROCESS | 1945 | |1;ext.html;410.81513319006444;438.35124016455643;485.1897331456465;488.8414457735168;525.5716590978354;38351.80824095879;41094.97262568437;41097.79451102744;41098.97252568687;41257.58742412575;41667.37498937511;42131.368029479585;42163.57836421635;42264;42289.73130806073;8330.791730206764;8529.275011624019;9199.54002299884;9430.198433133191;11210.607628732996;11067.391293478855;11336.886631133706;11339.943300283487;11345.37600431976;11350.375729334883;11300.830487542693;11328;11355.261907975997;11364.943175284112;11384.943075284613;8415.326773858107;8601.655933762642;11107.611233606785;11245.156613253997;11363.204575679705;11218.775624487545;11276.887231127666;11295.322280663104;11311.604093856758;11312.717182070432;40130.799346003376;40407;40503.59496405057;40505.392419113734;40551.39172912409;4015.738976966517;4027.6375126238486;4028.798560072014;4049.7165198436123;4180.498340199196;30393.863372252366;30396.54405183924;30402;30845.383092338252;31618.841905790323;3159.9842000790077;3181.538676891838;3189.6012998375204;3191.4734068878606;3292.308615190813;409673;415704;416464;417108;418253;59496;59683;59998.800023999276;60075.79848403008;60085.79828403408;63222.68388658027;63372.83135843281;63395.68302158552;63412.68293658502;63423.36576634175;15777.447789327318;16286.104264265343;16287.429939952044;16289.533941945281;16298.26657800378;11336.6032188873;11601;11612.6516204514;11710.355930423908;11731.120165987415;15411.998220115656;16971.896826706223;17400.303987840598;17437.12814359277;17931.551711207325;5924.407559244041;6935.826604334932;7007.509474336849;7132.041716847096;7154.749583764543;764.6979443119936;825.2655136928139;847.3898792869124;886.7871710789364;892.4734406699948;27009.459810804066;29790.40419191604;29922.70077299199;30238.69761302359;30396.54405183924;1045.4929359260752;1047.2564479219686;1063;1081.7079388565044;1187.1986409173774;14885;15218;15554.844451555566;15576;15970.76043859343;517580;517603.41198293766;517752;519712;521140;59763;60090.699546501986;60146.097808532904;60203.39796602065;60416.39583604196;1377.3113443278362;1396.2390497179063;1418.326295009862;1422.4523558430078;1425.1876430434552;28341.71658283473;29251.85374073116;29359.266018349714;30058.398832023675;30416.847915760278;50010.24984625161;50400.49599503958;50424.747876260386;50489.74755126201;50531.74734126306;460019;460410;461446;462188;462474.503059635;24290.75709242885;24974.750252497244;40078.99802504961;40127.59872401355;40391.798041010785;42001.78999104985;42738.145237095705;42765.5723442774;43022.35466468068;43207.567924320356;32524.674753252166;33805.492917606745;33908;34232.31535369229;34895.476567850994;29382.706172937997;33762.987110386726;34704;36071.45892811557;36534;33707;34280.657193427745;34820.65179348174;35069.64930350664;35361.82319088388;26512.337191570365;31536.053918382484;31546.526802098448;31581.8420907894;31732.206694832814;22503.549929001656;23664.053437862294;23926.16258431016;23945.281641550086;23945.64081538813 04:25:50 INFO - PROCESS | 1945 | |2;jquery.html;344.58649620455446;366.86242659002875;390.3091527995448;390.46701252789944;420.90108824426255;15223.847761522395;15638.296276667548;17844.553886152837;18643.813561864376;19808.70286945697;20482.078306476207;21379.67930481044;21393.35819925401;21853;21975.23086691966;5306.442823503535;5309.787608495665;5501.642393244446;5550.639208451458;5558.666480011192;5304.681719096847;5439.456054394549;5444.646098003617;5446.7276636168235;5465.562754979612;3902.590228026059;4094.283500387435;4579.862604121881;6096.939030609681;6129.41770531801;6124.693765311739;6147.846303842395;6151.569390142692;6158.261008678987;7635.274648908345;7728.729494467723;7811.33603643691;7897.328727058207;7910.960445197795;7917.604119794045;28889.711102888912;29923.95266165674;29974.250643733863;30085.796568137248;30335;2783.220698204506;2876.5786253263836;2921.649402071765;2928.282570770175;2979.1658335666048;16742.74885876713;17421.564460888454;17552.297908083663;17555.47333579982;18416.263349466004;1612.3711752416566;1976.545394559245;1993.461765323369;1993.6112458070681;2005.2179649936536;113670;116067.83932160655;134128;134233.32883335618;146943.69316449054;18444.538886527946;18487;20392.184312627625;21384.71691698472;22596.87015649211;40623;40727.59272407238;40873.97815054647;40945.79527102345;40969.590304097175;10760;10849.78300433987;10950.616728414467;11143.832842507369;11181.161412894066;8714.259287960467;8757.781055473664;8762.956185219033;8898.377113602115;8924.776880578038;10610.628627997983;10642;11067.667969960914;11169.609063682732;11178;3710.7959062251834;3962.6433620973676;4067.166230922713;4118.176364727066;4165.396017577495;888.6312180445043;901.3555307954844;917.1195652173988;973.7370909854442;1058.5077938758513;20582.015607736794;21838.563228735653;21935.232266870582;21995.120195192012;22027.66958495624;990.9594925328377;1026.2764750850633;1061.7239517725448;1067.8398240264023;1082.3127314155568;6743.123393958754;10545.941676913762;10891.747449043462;11036.724081898017;11419.20065595417;546743;623812;632248;633197;634758;147423;150226;151176.2441187787;151590.48409515983;153360;968.7529679931713;988.7478692933256;1012.5038731021747;1047.680457460497;1050.0654417568371;18406.53983650366;19222.423327300203;19358.709619356003;19408.61182776365;19411.320603779364;58521;59457;59747.40252597592;61130.694346527984;61490.232939516936;87356.5632171835;87739;89140;89187;89356.29827762814;7356.595387253752;7655.387568994578;7667.654955526903;7845.764627061198;8371.330293576377;11239.269447486215;12389.876101238871;13097.803532946822;13394.598162055154;13547.59357219285;10831.350118992885;11459.31244125355;11774.646760597196;11982.820257695967;12098.213616114925;10945.781084378426;11439.714007149887;11514.194006419806;11757.118216133653;12051.215416600257;10675.359478431319;11596.768064638829;11973.102017348909;12090.75818483643;12152.453139608915;7364.263573642593;8129.8374032520205;8455.055337272339;8566.657333706582;8708.956455217683;8446.915530844613;9411.623535058794;11351.829722554334;11669;11670 04:25:50 INFO - PROCESS | 1945 | |3;mootools.html;1424.4729450103457;1429.228216762948;1440.4958264607396;1441.084911081463;1448.0659974316563;7885;8271.214234647714;8284.295834854045;8285.875711864326;8308.376871734621;7298.452616053791;7627;7811.453198276123;8048.517088974651;8125.674973001088;1938.7382703335081;2239.6304609739414;2241.293992392399;2270.3075561953597;2277.908883644652;1748.3181559191926;1990.6317331293758;2176.7387913450407;2202.8347873909443;2278.5670722562745;1973.2304401283511;2052.6510493216188;2056.085042156241;2177.7604463509;2245.9438514037197;1872.7939926608062;2246.8764217968005;2269.387265438339;2269.614165591853;2284.64587988862;2229.9665505017438;2284.4403121235405;2293.575688497633;2298.367948814073;2303.7465878753324;7476.588787616679;7562.810929726746;7570.091589009354;7573.9621301893685;7577.962110189414;4990.25146228065;5108.923366149511;5139.12634852076;5159.922601160985;5162.45794191612;3271.313024264907;3441.8795342163153;3445.2248244145117;3497.3704733148024;3510.1400156961454;1152.3374059915582;1215.3801561203761;1217.3487184356327;1259.5276771210797;1265.5191027409617;10527.315724477885;10568.207384446121;10614.946925265402;10632.734181645443;10661.893381066246;4357.716748411343;4509.278515437514;4534.841280555231;4587.311903214544;4593.081383723269;9257.814843703223;9287.628494860264;9299.72100836976;9321.44071355721;9328.300377471716;5113.616478764033;5119.206522988943;5139.743012849342;5140.974295128501;5158.09733296679;4628.421447319085;4633.837815676435;4668.229742092517;4707.411573553306;4733.100710864925;3726.6087060858763;3733.8693145739767;3791.33651610967;3840.4431357453013;3856.325143099946;1252.7870262055471;1254.1095821966505;1256.6355756830417;1269.847618285793;1275.7002104505434;758.5069704691884;899.150302963706;909.5952301225891;934.7878884004127;936.4474959773767;5383.327084114486;5411.227349336255;5618.213450116987;5693.743781529841;5746.5977381583725;540.5054375246606;545.5826292885945;558.8658721906713;570.3697414357158;573.5526289494201;3678.521792167001;3755.962440375616;3790.1282704977457;3795.8102094895144;3825.8660946866726;9028.683996060106;9628.085331893459;9750;9773.02269773017;9776.120149186465;8397.958010210032;9683.661071862593;9693.903060969442;9718.465484398284;9733.610655573839;7394.926050739424;7759.961200194076;7761.146273909865;7767.262110099531;7772.883406748903;5514.310711161105;5562.527185189142;5638.4925356718095;5675.631083979528;5714.828555143353;8739.475631462132;9171.816563668555;9197.126273004054;9213.309001824757;9213.861792073258;8682.739517814476;9070.637174512945;9236.630534778533;9245.445273283625;9247.583858726239;7022;7199.928000720135;7212.783616491513;7221.4222862171955;7227.9638601806655;7763;7831.765047048598;7837.451378403457;7841.647125879464;7846.725364612211;6971.3028697129885;7025.859482810213;7109.680064397011;7184.497085203986;7188.029616001772;6938.722451102101;6946.8610627788175;6954.617496037767;7026.2271150174465;7045.26024767392;4941.629377796751;6295.937040629535;6331.303556608861;6383.39357761012;6414.198225221848;4888.095702295087;4942.604591632733;4984.925226121539;5002.874928126826;5089.414717307557;4877.5366340197625;4923.753812309442;4996.350474438445;5081.898362032664;5144.6913185209005 04:25:50 INFO - PROCESS | 1945 | |4;prototype.html;279.53038894656976;327.64614216646027;328.05029439771874;345.8167171399158;374.69462388153653;4153.56387579304;4811.615070794337;5170.414792603693;5296.179092240699;5320.749623838395;4991.251312303148;4996.975015124919;5040.227874668935;5063.924041139386;5213.478652134785;3262.804231746091;3667.413213885772;4152.5432202457705;4168.7290326128705;4168.9994401343765;3395.3718562065974;3950.940735888964;4105.979470102645;4114.40341150533;4152.937705934413;3438.742094342922;4007.7375626677504;4179.247735407625;4197.916041679165;4203.600657937491;4165.729227600196;4183.644390226835;4184.033504252996;4190.937135942963;4335.544767799399;2913.5286680226563;3130.796498227608;3701.481792549045;3743.5320584926885;3745.7190710696536;4213.514026724217;4670.089332580148;5108.062863853299;5125.00062487815;5188.610854185951;4202.516710578292;4535.455745310551;4797.832075877328;4799.784009719571;4820.734859582722;4979.904421027368;5601.943980560183;5613.989481893258;5624.437556244384;5634.323881134249;3251.301419821566;4079.8980025499304;4099.262132816092;4103.610157035077;4115.36211887158;5916.7337469813965;5943.3165186003735;5948.821535353946;5958.659301657092;5964.25446819152;3197.832791031257;3986;4059.411385349108;4143.875683729493;4190.057237121623;4192.81132349045;4205.86441660756;4217.840093974181;4219.346001369792;4246.428821336125;3855.4409610606303;4524.298733696282;4599.770011499479;4650.488446270908;4762.690425122356;4909.968906529597;5498.45015498447;5618.747156377973;5669.116655091276;5725.942740572541;1196.9820452693216;1354.4717560151548;1379.675776192594;1383.3083458270864;1392.0255820925393;710.9502334836512;814.3322475570094;883.1786438612024;891.4562117108559;971.3540495570508;4407.237105157898;4940.283658869444;4944.206523314316;4962.454130045692;4987.401511818605;4480.686351955397;4878.902421951541;4926.842192084857;5466.262054622575;5483.835484935458;4224.619784219435;4409.823607055682;4811.591014763784;4884.633652476078;5262.184361423985;2583.8966441342136;2714.217926625225;2780.7358300961378;2804.943901121966;2895.6235689360246;4559.840405585788;5427.534565667248;5483.806477408989;5516.972415137899;5764;4707.152712511781;5618.4662457066515;5619;5681.517071048925;5695.800646977419;5421.972890135524;5553.028220061473;5722.399148089474;5729;5757.769689212469;4488.057507923372;4999.925001124913;5152.433232344364;5352.919706204488;5529.889402212014;5039.370078740158;5089.956558905489;5195.454477279831;5257.921131182959;5475.260839786578;4881.925976285212;5179.559737422362;5330.9733451332495;5709.115087161496;5747.166660834072;3527.8236088194976;3656.451532270181;3658.9451158233182;3680.5767336756617;3687.852485900534;4585.656075794262;4863.076015557032;5531.806386776443;5571.607098225443;5581.325602319369;4953.702777833341;5389.919151212814;5573.303337082864;5578.386377498553;5580.748866300945;4685.835995740133;5539.916901246565;5579.386267510652;5589.580781441489;5590.9440905592055;4951.554360107608;4982.601391888713;5219.399769026611;5419.783208671766;5439.564834813126;5330;5482.342118945592;5573.804916827891;5586.8936331795285;5589.273394458694;4399.67002474822;5270.31485906845;5445.863853403696;5486.670799752028;5493.780248790164 04:25:50 INFO - PROCESS | 1945 | |5;yui.html;652.2694582068084;711.6299524247395;713.137104104034;820.9261166495015;861.1345597674336;15103.84896151038;15778.684426311467;15787.28957196926;15795.76306355404;15811.841881581195;12155.270683758981;14408.855911440882;14431.567052988401;14534.273286335667;15351.385944562204;841.188253335531;873;873.2664561768114;873.3144481581959;873.829603227371;859.8065435277075;860.3504354212561;862.7713655881197;863.1239292118505;863.6372723456132;919.6827094652334;922.529509949927;922.9353945223837;923.4782347973373;926.458022057094;915.5971372596069;915.7298596913927;915.7756349694301;917.0783362720423;917.312015988009;565.4797586220686;676.6954870308381;676.7800464848895;676.8003438985462;678.647103506179;15591.532254032398;15621.92189039059;15649.452269170524;15654.530364089096;15676.529704108894;11434.199606027581;13598.456061757517;13963.952703547173;14063.156210627396;14102.294885255696;10983.286086404438;11754;11769.234999724991;11808.645740627795;11959.880401195964;3640.908977275589;3657.7622454540638;3671.4492826076034;3706.870259540903;3810.7141964352786;96852;97573.58492452801;97758.55603609896;98278;99672;10529.684109476728;10586.788264234827;10589.523471443803;10652.414117223627;10968.890311096788;20281.79718202799;20329.898350508447;21012.949352532312;21272.680909786366;21277.574448511252;7453.254674532612;7481.214472480311;7596.430267729942;7624.618769061524;7743.9612801936755;3526.717862570988;4120.681381957745;4194.30793919006;4195.853145139906;4196.265653510623;3437.364087643794;3555.306715190565;3555.5022296878456;3558.1638314995957;3560.394732895414;553.3525774843442;645.2450632759683;650.3041745332449;683.6205905722272;710.5523520182252;662.3442791636342;696.2619623199424;696.4010950582496;704.503325155764;713.53263612334;8974.730758077269;9609.990950950189;10108.39349639024;10358.290882004536;10442.947785261025;562.9240052592847;567.1322875999728;570.1988705868262;607.3076692570473;682.2086379799409;4111.951980696587;4300.1399720056115;4550.112728018004;4565.794539245676;4679.578837904605;93433.5328323354;94575.58136627956;95558.5222073899;96781;99509.00490995143;59401.70299148563;63930.36069639337;64480.35519644837;64645.70708585802;84587.5770621143;61313.16060518192;74189.62905185547;77847;78161.60919195367;79971.20028799637;10403.583856645952;10725.839112413163;10917.017468427879;11013.504392302206;11069.391183484664;44400.66994975325;45081.774591126836;46885.06229875315;48754.512454874995;50021;64644.353556465714;65090;65873.34126658672;66505.66747166234;66774.33225667682;12403.441845116811;12466.5013399463;12668.429920653409;12772.680682982627;12832.358382081045;14238.128668946847;14550.41798328055;14704.41182352694;14847.851521484647;15038.02252853561;13249.470021199044;13538.255395953318;13540.93229533846;13541.458341666223;13988;13275.203487790763;13462.932685336511;13471;13568;13889.37497812621;12935.482580696667;13616.591502254552;13640.317984100953;13652.726945461234;13776.86223137796;9229.400088994462;11118.666440006813;11402.030827379765;11517.53929842797;11773.941130294294;9797.510124493889;10455.94772026135;10768.515416806105;10768.676939691823;10846.67459976202 04:25:50 INFO - PROCESS | 1945 | __end_tp_report 04:25:50 INFO - PROCESS | 1945 | __start_cc_report 04:25:50 INFO - PROCESS | 1945 | _x_x_mozilla_cycle_collect,2340 04:25:50 INFO - PROCESS | 1945 | __end_cc_report 04:25:50 INFO - PROCESS | 1945 | __startTimestamp1485433550959__endTimestamp 04:25:50 INFO - PROCESS | 1945 | 04:25:50 INFO - PROCESS | 1945 | ------- Summary: start ------- 04:25:50 INFO - PROCESS | 1945 | Number of tests: 6 04:25:50 INFO - PROCESS | 1945 | 04:25:50 INFO - PROCESS | 1945 | [#0] dojo.html Cycles:165 Average:5610.31 Median:5819.65 stddev:662.07 (11.4%) stddev-sans-first:623.95 04:25:50 INFO - PROCESS | 1945 | Values: 2715.8 3271.1 3294.5 3308.3 3343.8 5419.8 5453.6 5506.4 5550.9 5561.4 5495.4 5512.6 5578.5 5579.2 5614.5 5016.6 5025.6 5056.7 5071.4 5115.0 4156.6 5187.3 5205.1 5209.2 5251.7 5038.0 5154.3 5160.2 5184.7 5211.9 5061.9 5092.2 5115.5 5130.9 5140.8 5059.6 5103.0 5110.5 5125.1 5150.4 5548.4 5551.7 5558.7 5566.1 5602.4 5928.4 5953.5 5963.0 5963.4 6106.4 6126.5 6133.3 6177.3 6205.0 6213.7 5669.1 5671.4 5677.6 5685.0 5731.9 6134.1 6191.7 6215.9 6299.1 6304.2 5868.0 5871.2 5914.8 5988.0 6009.6 6006.9 6139.4 6152.7 6157.1 6168.4 5872.8 5912.1 5957.3 5991.4 5992.9 5952.0 6016.4 6018.5 6027.2 6036.9 4620.1 4871.9 4878.8 4914.7 4926.1 3657.3 4320.2 4326.5 4328.5 4350.2 5621.0 5671.6 5684.1 5698.7 5739.1 6149.4 6155.4 6173.6 6175.0 6185.8 4577.4 5522.9 5660.5 5671.3 5688.9 5304.0 5310.8 5311.8 5319.5 5330.5 6250.5 6302.6 6322.2 6324.6 6325.8 6152.9 6199.9 6215.8 6219.0 6236.3 6127.8 6135.3 6258.3 6300.4 6302.3 5983.1 6014.7 6021.3 6102.6 6103.8 6089.7 6139.2 6159.7 6182.9 6211.3 5718.1 5919.4 5999.0 6000.7 6024.4 5730.4 5860.7 5869.6 5905.3 5980.3 5657.1 5696.5 5810.4 5814.7 5824.2 5836.3 5882.1 5890.1 5911.5 5918.1 5728.3 5819.7 5822.4 5833.6 5849.0 04:25:50 INFO - PROCESS | 1945 | 04:25:50 INFO - PROCESS | 1945 | [#1] ext.html Cycles:180 Average:61308.30 Median:34858.06 stddev:123985.06 (355.7%) stddev-sans-first:124248.56 04:25:50 INFO - PROCESS | 1945 | Values: 410.8 438.4 485.2 488.8 525.6 38351.8 41095.0 41097.8 41099.0 41257.6 41667.4 42131.4 42163.6 42264.0 42289.7 8330.8 8529.3 9199.5 9430.2 11210.6 11067.4 11336.9 11339.9 11345.4 11350.4 11300.8 11328.0 11355.3 11364.9 11384.9 8415.3 8601.7 11107.6 11245.2 11363.2 11218.8 11276.9 11295.3 11311.6 11312.7 40130.8 40407.0 40503.6 40505.4 40551.4 4015.7 4027.6 4028.8 4049.7 4180.5 30393.9 30396.5 30402.0 30845.4 31618.8 3160.0 3181.5 3189.6 3191.5 3292.3 409673.0 415704.0 416464.0 417108.0 418253.0 59496.0 59683.0 59998.8 60075.8 60085.8 63222.7 63372.8 63395.7 63412.7 63423.4 15777.4 16286.1 16287.4 16289.5 16298.3 11336.6 11601.0 11612.7 11710.4 11731.1 15412.0 16971.9 17400.3 17437.1 17931.6 5924.4 6935.8 7007.5 7132.0 7154.7 764.7 825.3 847.4 886.8 892.5 27009.5 29790.4 29922.7 30238.7 30396.5 1045.5 1047.3 1063.0 1081.7 1187.2 14885.0 15218.0 15554.8 15576.0 15970.8 517580.0 517603.4 517752.0 519712.0 521140.0 59763.0 60090.7 60146.1 60203.4 60416.4 1377.3 1396.2 1418.3 1422.5 1425.2 28341.7 29251.9 29359.3 30058.4 30416.8 50010.2 50400.5 50424.7 50489.7 50531.7 460019.0 460410.0 461446.0 462188.0 462474.5 24290.8 24974.8 40079.0 40127.6 40391.8 42001.8 42738.1 42765.6 43022.4 43207.6 32524.7 33805.5 33908.0 34232.3 34895.5 29382.7 33763.0 34704.0 36071.5 36534.0 33707.0 34280.7 34820.7 35069.6 35361.8 26512.3 31536.1 31546.5 31581.8 31732.2 22503.5 23664.1 23926.2 23945.3 23945.6 04:25:50 INFO - PROCESS | 1945 | 04:25:50 INFO - PROCESS | 1945 | [#2] jquery.html Cycles:180 Average:38555.90 Median:2829.90 stddev:103315.60 (3650.9%) stddev-sans-first:103565.59 04:25:50 INFO - PROCESS | 1945 | Values: 344.6 366.9 390.3 390.5 420.9 15223.8 15638.3 17844.6 18643.8 19808.7 20482.1 21379.7 21393.4 21853.0 21975.2 5306.4 5309.8 5501.6 5550.6 5558.7 5304.7 5439.5 5444.6 5446.7 5465.6 3902.6 4094.3 4579.9 6096.9 6129.4 6124.7 6147.8 6151.6 6158.3 7635.3 7728.7 7811.3 7897.3 7911.0 7917.6 28889.7 29924.0 29974.3 30085.8 30335.0 2783.2 2876.6 2921.6 2928.3 2979.2 16742.7 17421.6 17552.3 17555.5 18416.3 1612.4 1976.5 1993.5 1993.6 2005.2 113670.0 116067.8 134128.0 134233.3 146943.7 18444.5 18487.0 20392.2 21384.7 22596.9 40623.0 40727.6 40874.0 40945.8 40969.6 10760.0 10849.8 10950.6 11143.8 11181.2 8714.3 8757.8 8763.0 8898.4 8924.8 10610.6 10642.0 11067.7 11169.6 11178.0 3710.8 3962.6 4067.2 4118.2 4165.4 888.6 901.4 917.1 973.7 1058.5 20582.0 21838.6 21935.2 21995.1 22027.7 991.0 1026.3 1061.7 1067.8 1082.3 6743.1 10545.9 10891.7 11036.7 11419.2 546743.0 623812.0 632248.0 633197.0 634758.0 147423.0 150226.0 151176.2 151590.5 153360.0 968.8 988.7 1012.5 1047.7 1050.1 18406.5 19222.4 19358.7 19408.6 19411.3 58521.0 59457.0 59747.4 61130.7 61490.2 87356.6 87739.0 89140.0 89187.0 89356.3 7356.6 7655.4 7667.7 7845.8 8371.3 11239.3 12389.9 13097.8 13394.6 13547.6 10831.4 11459.3 11774.6 11982.8 12098.2 10945.8 11439.7 11514.2 11757.1 12051.2 10675.4 11596.8 11973.1 12090.8 12152.5 7364.3 8129.8 8455.1 8566.7 8709.0 8446.9 9411.6 11351.8 11669.0 11670.0 04:25:50 INFO - PROCESS | 1945 | 04:25:50 INFO - PROCESS | 1945 | [#3] mootools.html Cycles:180 Average:5315.11 Median:5272.89 stddev:2894.93 (54.9%) stddev-sans-first:2888.29 04:25:50 INFO - PROCESS | 1945 | Values: 1424.5 1429.2 1440.5 1441.1 1448.1 7885.0 8271.2 8284.3 8285.9 8308.4 7298.5 7627.0 7811.5 8048.5 8125.7 1938.7 2239.6 2241.3 2270.3 2277.9 1748.3 1990.6 2176.7 2202.8 2278.6 1973.2 2052.7 2056.1 2177.8 2245.9 1872.8 2246.9 2269.4 2269.6 2284.6 2230.0 2284.4 2293.6 2298.4 2303.7 7476.6 7562.8 7570.1 7574.0 7578.0 4990.3 5108.9 5139.1 5159.9 5162.5 3271.3 3441.9 3445.2 3497.4 3510.1 1152.3 1215.4 1217.3 1259.5 1265.5 10527.3 10568.2 10614.9 10632.7 10661.9 4357.7 4509.3 4534.8 4587.3 4593.1 9257.8 9287.6 9299.7 9321.4 9328.3 5113.6 5119.2 5139.7 5141.0 5158.1 4628.4 4633.8 4668.2 4707.4 4733.1 3726.6 3733.9 3791.3 3840.4 3856.3 1252.8 1254.1 1256.6 1269.8 1275.7 758.5 899.2 909.6 934.8 936.4 5383.3 5411.2 5618.2 5693.7 5746.6 540.5 545.6 558.9 570.4 573.6 3678.5 3756.0 3790.1 3795.8 3825.9 9028.7 9628.1 9750.0 9773.0 9776.1 8398.0 9683.7 9693.9 9718.5 9733.6 7394.9 7760.0 7761.1 7767.3 7772.9 5514.3 5562.5 5638.5 5675.6 5714.8 8739.5 9171.8 9197.1 9213.3 9213.9 8682.7 9070.6 9236.6 9245.4 9247.6 7022.0 7199.9 7212.8 7221.4 7228.0 7763.0 7831.8 7837.5 7841.6 7846.7 6971.3 7025.9 7109.7 7184.5 7188.0 6938.7 6946.9 6954.6 7026.2 7045.3 4941.6 6295.9 6331.3 6383.4 6414.2 4888.1 4942.6 4984.9 5002.9 5089.4 4877.5 4923.8 4996.4 5081.9 5144.7 04:25:50 INFO - PROCESS | 1945 | 04:25:50 INFO - PROCESS | 1945 | [#4] prototype.html Cycles:180 Average:4447.46 Median:4933.56 stddev:1337.25 (27.1%) stddev-sans-first:1303.90 04:25:50 INFO - PROCESS | 1945 | Values: 279.5 327.6 328.1 345.8 374.7 4153.6 4811.6 5170.4 5296.2 5320.7 4991.3 4997.0 5040.2 5063.9 5213.5 3262.8 3667.4 4152.5 4168.7 4169.0 3395.4 3950.9 4106.0 4114.4 4152.9 3438.7 4007.7 4179.2 4197.9 4203.6 4165.7 4183.6 4184.0 4190.9 4335.5 2913.5 3130.8 3701.5 3743.5 3745.7 4213.5 4670.1 5108.1 5125.0 5188.6 4202.5 4535.5 4797.8 4799.8 4820.7 4979.9 5601.9 5614.0 5624.4 5634.3 3251.3 4079.9 4099.3 4103.6 4115.4 5916.7 5943.3 5948.8 5958.7 5964.3 3197.8 3986.0 4059.4 4143.9 4190.1 4192.8 4205.9 4217.8 4219.3 4246.4 3855.4 4524.3 4599.8 4650.5 4762.7 4910.0 5498.5 5618.7 5669.1 5725.9 1197.0 1354.5 1379.7 1383.3 1392.0 711.0 814.3 883.2 891.5 971.4 4407.2 4940.3 4944.2 4962.5 4987.4 4480.7 4878.9 4926.8 5466.3 5483.8 4224.6 4409.8 4811.6 4884.6 5262.2 2583.9 2714.2 2780.7 2804.9 2895.6 4559.8 5427.5 5483.8 5517.0 5764.0 4707.2 5618.5 5619.0 5681.5 5695.8 5422.0 5553.0 5722.4 5729.0 5757.8 4488.1 4999.9 5152.4 5352.9 5529.9 5039.4 5090.0 5195.5 5257.9 5475.3 4881.9 5179.6 5331.0 5709.1 5747.2 3527.8 3656.5 3658.9 3680.6 3687.9 4585.7 4863.1 5531.8 5571.6 5581.3 4953.7 5389.9 5573.3 5578.4 5580.7 4685.8 5539.9 5579.4 5589.6 5590.9 4951.6 4982.6 5219.4 5419.8 5439.6 5330.0 5482.3 5573.8 5586.9 5589.3 4399.7 5270.3 5445.9 5486.7 5493.8 04:25:50 INFO - PROCESS | 1945 | 04:25:50 INFO - PROCESS | 1945 | [#5] yui.html Cycles:180 Average:19193.83 Median:4196.06 stddev:26610.04 (634.2%) stddev-sans-first:26648.27 04:25:50 INFO - PROCESS | 1945 | Values: 652.3 711.6 713.1 820.9 861.1 15103.8 15778.7 15787.3 15795.8 15811.8 12155.3 14408.9 14431.6 14534.3 15351.4 841.2 873.0 873.3 873.3 873.8 859.8 860.4 862.8 863.1 863.6 919.7 922.5 922.9 923.5 926.5 915.6 915.7 915.8 917.1 917.3 565.5 676.7 676.8 676.8 678.6 15591.5 15621.9 15649.5 15654.5 15676.5 11434.2 13598.5 13964.0 14063.2 14102.3 10983.3 11754.0 11769.2 11808.6 11959.9 3640.9 3657.8 3671.4 3706.9 3810.7 96852.0 97573.6 97758.6 98278.0 99672.0 10529.7 10586.8 10589.5 10652.4 10968.9 20281.8 20329.9 21012.9 21272.7 21277.6 7453.3 7481.2 7596.4 7624.6 7744.0 3526.7 4120.7 4194.3 4195.9 4196.3 3437.4 3555.3 3555.5 3558.2 3560.4 553.4 645.2 650.3 683.6 710.6 662.3 696.3 696.4 704.5 713.5 8974.7 9610.0 10108.4 10358.3 10442.9 562.9 567.1 570.2 607.3 682.2 4112.0 4300.1 4550.1 4565.8 4679.6 93433.5 94575.6 95558.5 96781.0 99509.0 59401.7 63930.4 64480.4 64645.7 84587.6 61313.2 74189.6 77847.0 78161.6 79971.2 10403.6 10725.8 10917.0 11013.5 11069.4 44400.7 45081.8 46885.1 48754.5 50021.0 64644.4 65090.0 65873.3 66505.7 66774.3 12403.4 12466.5 12668.4 12772.7 12832.4 14238.1 14550.4 14704.4 14847.9 15038.0 13249.5 13538.3 13540.9 13541.5 13988.0 13275.2 13462.9 13471.0 13568.0 13889.4 12935.5 13616.6 13640.3 13652.7 13776.9 9229.4 11118.7 11402.0 11517.5 11773.9 9797.5 10455.9 10768.5 10768.7 10846.7 04:25:50 INFO - PROCESS | 1945 | -------- Summary: end -------- 04:25:50 INFO - PROCESS | 1945 | 04:25:51 INFO - TEST-INFO | 1945: exit 0 04:25:51 INFO - TEST-OK | dromaeo_css | took 1119384ms 04:25:51 INFO - TEST-START | kraken 04:25:51 INFO - operating with platform_type : mac_ 04:25:51 INFO - Initialising browser for kraken test... 04:25:51 INFO - TEST-INFO | started process 1948 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/tmpxgY6dz/profile http://localhost:53482/getInfo.html) 04:25:53 INFO - PROCESS | 1948 | __metrics Screen width/height:1600/1200 04:25:53 INFO - PROCESS | 1948 | colorDepth:24 04:25:53 INFO - PROCESS | 1948 | Browser inner width/height: 1024/689 04:25:53 INFO - PROCESS | 1948 | __metrics 04:25:53 INFO - PROCESS | 1948 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 692: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:25:53 INFO - PROCESS | 1948 | JavaScript error: resource://app/modules/BrowserUsageTelemetry.jsm, line 303: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:25:54 INFO - TEST-INFO | 1948: exit 0 04:25:54 INFO - Browser initialized. 04:25:54 INFO - Running cycle 1/1 for kraken test... 04:25:54 INFO - TEST-INFO | started process 1949 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/T/tmpxgY6dz/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:26:06 INFO - PROCESS | 1949 | RSS: Main: 226861056 04:26:06 INFO - PROCESS | 1949 | 04:26:09 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53482/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:53482/tests/kraken/driver.html?testName=audio-beat-detection) 04:26:10 INFO - PROCESS | 1949 | RSS: Main: 288124928 04:26:10 INFO - PROCESS | 1949 | 04:26:13 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53482/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:53482/tests/kraken/driver.html?testName=audio-dft) 04:26:13 INFO - PROCESS | 1949 | RSS: Main: 289804288 04:26:13 INFO - PROCESS | 1949 | 04:26:17 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53482/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:53482/tests/kraken/driver.html?testName=audio-fft) 04:26:17 INFO - PROCESS | 1949 | RSS: Main: 379572224 04:26:17 INFO - PROCESS | 1949 | 04:26:19 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53482/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:53482/tests/kraken/driver.html?testName=audio-oscillator) 04:26:20 INFO - PROCESS | 1949 | RSS: Main: 282759168 04:26:20 INFO - PROCESS | 1949 | 04:26:22 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53482/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:53482/tests/kraken/driver.html?testName=imaging-gaussian-blur) 04:26:23 INFO - PROCESS | 1949 | RSS: Main: 286191616 04:26:23 INFO - PROCESS | 1949 | 04:26:25 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53482/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:53482/tests/kraken/driver.html?testName=imaging-darkroom) 04:26:26 INFO - PROCESS | 1949 | RSS: Main: 329388032 04:26:26 INFO - PROCESS | 1949 | 04:26:29 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53482/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:53482/tests/kraken/driver.html?testName=imaging-desaturate) 04:26:29 INFO - PROCESS | 1949 | RSS: Main: 331972608 04:26:29 INFO - PROCESS | 1949 | 04:26:32 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53482/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:53482/tests/kraken/driver.html?testName=json-parse-financial) 04:26:33 INFO - PROCESS | 1949 | RSS: Main: 330031104 04:26:33 INFO - PROCESS | 1949 | 04:26:35 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53482/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:53482/tests/kraken/driver.html?testName=json-stringify-tinderbox) 04:26:35 INFO - PROCESS | 1949 | RSS: Main: 305876992 04:26:35 INFO - PROCESS | 1949 | 04:26:37 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53482/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:53482/tests/kraken/driver.html?testName=stanford-crypto-aes) 04:26:38 INFO - PROCESS | 1949 | RSS: Main: 309891072 04:26:38 INFO - PROCESS | 1949 | 04:26:40 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53482/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:53482/tests/kraken/driver.html?testName=stanford-crypto-ccm) 04:26:41 INFO - PROCESS | 1949 | RSS: Main: 313630720 04:26:41 INFO - PROCESS | 1949 | 04:26:43 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53482/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:53482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 04:26:44 INFO - PROCESS | 1949 | RSS: Main: 327065600 04:26:44 INFO - PROCESS | 1949 | 04:26:47 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53482/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:53482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 04:26:48 INFO - PROCESS | 1949 | RSS: Main: 321490944 04:26:48 INFO - PROCESS | 1949 | 04:26:50 INFO - PROCESS | 1949 | Cycle 1(1): loaded http://localhost:53482/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:53482/tests/kraken/driver.html?testName=ai-astar) 04:26:50 INFO - PROCESS | 1949 | RSS: Main: 366956544 04:26:50 INFO - PROCESS | 1949 | 04:26:50 INFO - PROCESS | 1949 | __start_tp_report 04:26:50 INFO - PROCESS | 1949 | _x_x_mozilla_page_load 04:26:50 INFO - PROCESS | 1949 | _x_x_mozilla_page_load_details 04:26:50 INFO - PROCESS | 1949 | |i|pagename|runs| 04:26:50 INFO - PROCESS | 1949 | |0;ai-astar;104;114;113;114;113;114;113;113;113;114 04:26:50 INFO - PROCESS | 1949 | |1;audio-beat-detection;143;107;110;148;113;112;109;110;131;110 04:26:50 INFO - PROCESS | 1949 | |2;audio-dft;197;230;257;223;185;181;184;185;184;182 04:26:50 INFO - PROCESS | 1949 | |3;audio-fft;80;57;57;94;76;68;59;59;75;62 04:26:50 INFO - PROCESS | 1949 | |4;audio-oscillator;92;70;86;70;68;70;82;69;70;83 04:26:50 INFO - PROCESS | 1949 | |5;imaging-gaussian-blur;88;85;88;86;88;84;88;86;88;85 04:26:50 INFO - PROCESS | 1949 | |6;imaging-darkroom;93;94;94;95;94;94;95;94;94;94 04:26:50 INFO - PROCESS | 1949 | |7;imaging-desaturate;87;98;132;87;86;95;85;88;89;86 04:26:50 INFO - PROCESS | 1949 | |8;json-parse-financial;54;52;52;54;55;55;55;54;55;54 04:26:50 INFO - PROCESS | 1949 | |9;json-stringify-tinderbox;66;76;71;79;73;71;72;72;73;71 04:26:50 INFO - PROCESS | 1949 | |10;stanford-crypto-aes;85;90;87;87;91;90;89;87;86;89 04:26:50 INFO - PROCESS | 1949 | |11;stanford-crypto-ccm;142;139;142;139;138;138;139;141;204;176 04:26:50 INFO - PROCESS | 1949 | |12;stanford-crypto-pbkdf2;174;181;176;175;173;171;173;174;173;175 04:26:50 INFO - PROCESS | 1949 | |13;stanford-crypto-sha256-iterative;66;68;67;68;68;68;66;67;68;67 04:26:50 INFO - PROCESS | 1949 | __end_tp_report 04:26:50 INFO - PROCESS | 1949 | __start_cc_report 04:26:50 INFO - PROCESS | 1949 | _x_x_mozilla_cycle_collect,1998 04:26:50 INFO - PROCESS | 1949 | __end_cc_report 04:26:50 INFO - PROCESS | 1949 | __startTimestamp1485433610313__endTimestamp 04:26:50 INFO - PROCESS | 1949 | 04:26:50 INFO - PROCESS | 1949 | ------- Summary: start ------- 04:26:50 INFO - PROCESS | 1949 | Number of tests: 14 04:26:50 INFO - PROCESS | 1949 | 04:26:50 INFO - PROCESS | 1949 | [#0] ai-astar Cycles:10 Average:112.50 Median:113.50 stddev:3.03 (2.7%) stddev-sans-first:0.53 04:26:50 INFO - PROCESS | 1949 | Values: 104.0 114.0 113.0 114.0 113.0 114.0 113.0 113.0 113.0 114.0 04:26:50 INFO - PROCESS | 1949 | 04:26:50 INFO - PROCESS | 1949 | [#1] audio-beat-detection Cycles:10 Average:119.30 Median:112.50 stddev:15.39 (13.7%) stddev-sans-first:13.73 04:26:50 INFO - PROCESS | 1949 | Values: 143.0 107.0 110.0 148.0 113.0 112.0 109.0 110.0 131.0 110.0 04:26:50 INFO - PROCESS | 1949 | 04:26:50 INFO - PROCESS | 1949 | [#2] audio-dft Cycles:10 Average:200.80 Median:191.00 stddev:26.52 (13.9%) stddev-sans-first:28.09 04:26:50 INFO - PROCESS | 1949 | Values: 197.0 230.0 257.0 223.0 185.0 181.0 184.0 185.0 184.0 182.0 04:26:50 INFO - PROCESS | 1949 | 04:26:50 INFO - PROCESS | 1949 | [#3] audio-fft Cycles:10 Average:68.70 Median:71.50 stddev:12.33 (17.2%) stddev-sans-first:12.38 04:26:50 INFO - PROCESS | 1949 | Values: 80.0 57.0 57.0 94.0 76.0 68.0 59.0 59.0 75.0 62.0 04:26:50 INFO - PROCESS | 1949 | 04:26:50 INFO - PROCESS | 1949 | [#4] audio-oscillator Cycles:10 Average:76.00 Median:76.00 stddev:8.81 (11.6%) stddev-sans-first:7.19 04:26:50 INFO - PROCESS | 1949 | Values: 92.0 70.0 86.0 70.0 68.0 70.0 82.0 69.0 70.0 83.0 04:26:50 INFO - PROCESS | 1949 | 04:26:50 INFO - PROCESS | 1949 | [#5] imaging-gaussian-blur Cycles:10 Average:86.60 Median:88.00 stddev:1.58 (1.8%) stddev-sans-first:1.59 04:26:50 INFO - PROCESS | 1949 | Values: 88.0 85.0 88.0 86.0 88.0 84.0 88.0 86.0 88.0 85.0 04:26:50 INFO - PROCESS | 1949 | 04:26:50 INFO - PROCESS | 1949 | [#6] imaging-darkroom Cycles:10 Average:94.10 Median:94.00 stddev:0.57 (0.6%) stddev-sans-first:0.44 04:26:50 INFO - PROCESS | 1949 | Values: 93.0 94.0 94.0 95.0 94.0 94.0 95.0 94.0 94.0 94.0 04:26:50 INFO - PROCESS | 1949 | 04:26:50 INFO - PROCESS | 1949 | [#7] imaging-desaturate Cycles:10 Average:93.30 Median:87.50 stddev:14.24 (16.3%) stddev-sans-first:14.92 04:26:50 INFO - PROCESS | 1949 | Values: 87.0 98.0 132.0 87.0 86.0 95.0 85.0 88.0 89.0 86.0 04:26:50 INFO - PROCESS | 1949 | 04:26:50 INFO - PROCESS | 1949 | [#8] json-parse-financial Cycles:10 Average:54.00 Median:54.50 stddev:1.15 (2.1%) stddev-sans-first:1.22 04:26:50 INFO - PROCESS | 1949 | Values: 54.0 52.0 52.0 54.0 55.0 55.0 55.0 54.0 55.0 54.0 04:26:50 INFO - PROCESS | 1949 | 04:26:50 INFO - PROCESS | 1949 | [#9] json-stringify-tinderbox Cycles:10 Average:72.40 Median:72.50 stddev:3.41 (4.7%) stddev-sans-first:2.71 04:26:50 INFO - PROCESS | 1949 | Values: 66.0 76.0 71.0 79.0 73.0 71.0 72.0 72.0 73.0 71.0 04:26:50 INFO - PROCESS | 1949 | 04:26:50 INFO - PROCESS | 1949 | [#10] stanford-crypto-aes Cycles:10 Average:88.10 Median:89.00 stddev:1.97 (2.2%) stddev-sans-first:1.74 04:26:50 INFO - PROCESS | 1949 | Values: 85.0 90.0 87.0 87.0 91.0 90.0 89.0 87.0 86.0 89.0 04:26:50 INFO - PROCESS | 1949 | 04:26:50 INFO - PROCESS | 1949 | [#11] stanford-crypto-ccm Cycles:10 Average:149.80 Median:141.50 stddev:22.24 (15.7%) stddev-sans-first:23.41 04:26:50 INFO - PROCESS | 1949 | Values: 142.0 139.0 142.0 139.0 138.0 138.0 139.0 141.0 204.0 176.0 04:26:50 INFO - PROCESS | 1949 | 04:26:50 INFO - PROCESS | 1949 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:174.50 Median:174.50 stddev:2.68 (1.5%) stddev-sans-first:2.83 04:26:50 INFO - PROCESS | 1949 | Values: 174.0 181.0 176.0 175.0 173.0 171.0 173.0 174.0 173.0 175.0 04:26:50 INFO - PROCESS | 1949 | 04:26:50 INFO - PROCESS | 1949 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.30 Median:68.00 stddev:0.82 (1.2%) stddev-sans-first:0.73 04:26:50 INFO - PROCESS | 1949 | Values: 66.0 68.0 67.0 68.0 68.0 68.0 66.0 67.0 68.0 67.0 04:26:50 INFO - PROCESS | 1949 | -------- Summary: end -------- 04:26:50 INFO - PROCESS | 1949 | 04:26:51 INFO - TEST-INFO | 1949: exit 0 04:26:51 INFO - TEST-OK | kraken | took 59770ms 04:26:51 INFO - SUITE-END | took 1179s 04:26:51 INFO - Completed test suite (00:19:39) 04:26:51 INFO - javascript benchmark 04:26:51 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"lowerIsBetter": false, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2715.769159621432, 3271.0513950954223, 3294.489354150107, 3308.2887179256454, 3343.7826541274817, 5419.756110975006, 5453.64551304165, 5506.366767821702, 5550.91673624896, 5561.388247292794, 5495.395506494282, 5512.586556008306, 5578.525825304844, 5579.246801681772, 5614.522765564921, 5016.623753218505, 5025.572826309768, 5056.696598204101, 5071.391433028042, 5115.002574497975, 4156.646685031776, 5187.273781670569, 5205.141151709963, 5209.244659524366, 5251.684898906059, 5038.017586570621, 5154.252633368178, 5160.225966105077, 5184.662996905208, 5211.895762084756, 5061.873453163664, 5092.185250359925, 5115.514026167508, 5130.871728206787, 5140.845774626767, 5059.569936555397, 5102.979404119191, 5110.5400513953555, 5125.103106956268, 5150.356205474316, 5548.361938377098, 5551.694656793875, 5558.749856256478, 5566.109422492423, 5602.439756024406, 5928.407159284037, 5953.493953013999, 5963.0, 5963.4334738199805, 6106.389361063858, 6126.5176737973225, 6133.285424838581, 6177.2587289525545, 6205.03821907605, 6213.689315534205, 5669.121286200645, 5671.404502527258, 5677.574181936371, 5685.0, 5731.856703582402, 6134.1119512865025, 6191.690415479208, 6215.906761398583, 6299.0866324382705, 6304.211973503312, 5867.970660146672, 5871.236739223874, 5914.792982245687, 5988.011978023665, 6009.639421634716, 6006.909896351558, 6139.447449729457, 6152.661603611844, 6157.138000679908, 6168.383161683885, 5872.765089396376, 5912.083627037816, 5957.255343082114, 5991.370906054802, 5992.910106348409, 5951.970240148771, 6016.428439298347, 6018.548608854353, 6027.21646185993, 6036.939630603725, 4620.052889157714, 4871.853844384674, 4878.780454879539, 4914.655974081851, 4926.064047830901, 3657.2685462906993, 4320.243957307459, 4326.4808223012815, 4328.458942632171, 4350.195213885378, 5620.971895140498, 5671.602987790898, 5684.062129748545, 5698.715064246771, 5739.053056245672, 6149.41580549847, 6155.353687862799, 6173.629582225081, 6174.950258456073, 6185.8144255672405, 4577.359169716243, 5522.91715624266, 5660.5471562274915, 5671.291088613923, 5688.914666280009, 5304.045271851104, 5310.787568497217, 5311.814086506954, 5319.46805319465, 5330.466953304638, 6250.499960003189, 6302.621842689453, 6322.209723784527, 6324.557280990287, 6325.778597749057, 6152.907706384497, 6199.876002480015, 6215.844603884939, 6218.973869311513, 6236.314005459487, 6127.816165515042, 6135.294441139326, 6258.280297765815, 6300.401461861115, 6302.275238347649, 5983.102534619842, 6014.669193194416, 6021.307549631849, 6102.580142287504, 6103.761967187164, 6089.706984989208, 6139.246828488627, 6159.661218632839, 6182.907256391068, 6211.316755156839, 5718.085106382959, 5919.378465261086, 5998.970005149947, 6000.729967151401, 6024.3975602439405, 5730.398308177748, 5860.736266868086, 5869.647821130575, 5905.2913650360515, 5980.34216236205, 5657.066584013592, 5696.544276457957, 5810.448007439287, 5814.680192589448, 5824.184614153937, 5836.299644042742, 5882.088276317178, 5890.087036509177, 5911.467967882912, 5918.141869428822, 5728.342649122788, 5819.650820950587, 5822.388649191943, 5833.562482813721, 5849.034909240098], "value": 5565.417600458544, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.81513319006444, 438.35124016455643, 485.1897331456465, 488.8414457735168, 525.5716590978354, 38351.80824095879, 41094.97262568437, 41097.79451102744, 41098.97252568687, 41257.58742412575, 41667.37498937511, 42131.368029479585, 42163.57836421635, 42264.0, 42289.73130806073, 8330.791730206764, 8529.275011624019, 9199.54002299884, 9430.198433133191, 11210.607628732996, 11067.391293478855, 11336.886631133706, 11339.943300283487, 11345.37600431976, 11350.375729334883, 11300.830487542693, 11328.0, 11355.261907975997, 11364.943175284112, 11384.943075284613, 8415.326773858107, 8601.655933762642, 11107.611233606785, 11245.156613253997, 11363.204575679705, 11218.775624487545, 11276.887231127666, 11295.322280663104, 11311.604093856758, 11312.717182070432, 40130.799346003376, 40407.0, 40503.59496405057, 40505.392419113734, 40551.39172912409, 4015.738976966517, 4027.6375126238486, 4028.798560072014, 4049.7165198436123, 4180.498340199196, 30393.863372252366, 30396.54405183924, 30402.0, 30845.383092338252, 31618.841905790323, 3159.9842000790077, 3181.538676891838, 3189.6012998375204, 3191.4734068878606, 3292.308615190813, 409673.0, 415704.0, 416464.0, 417108.0, 418253.0, 59496.0, 59683.0, 59998.800023999276, 60075.79848403008, 60085.79828403408, 63222.68388658027, 63372.83135843281, 63395.68302158552, 63412.68293658502, 63423.36576634175, 15777.447789327318, 16286.104264265343, 16287.429939952044, 16289.533941945281, 16298.26657800378, 11336.6032188873, 11601.0, 11612.6516204514, 11710.355930423908, 11731.120165987415, 15411.998220115656, 16971.896826706223, 17400.303987840598, 17437.12814359277, 17931.551711207325, 5924.407559244041, 6935.826604334932, 7007.509474336849, 7132.041716847096, 7154.749583764543, 764.6979443119936, 825.2655136928139, 847.3898792869124, 886.7871710789364, 892.4734406699948, 27009.459810804066, 29790.40419191604, 29922.70077299199, 30238.69761302359, 30396.54405183924, 1045.4929359260752, 1047.2564479219686, 1063.0, 1081.7079388565044, 1187.1986409173774, 14885.0, 15218.0, 15554.844451555566, 15576.0, 15970.76043859343, 517580.0, 517603.41198293766, 517752.0, 519712.0, 521140.0, 59763.0, 60090.699546501986, 60146.097808532904, 60203.39796602065, 60416.39583604196, 1377.3113443278362, 1396.2390497179063, 1418.326295009862, 1422.4523558430078, 1425.1876430434552, 28341.71658283473, 29251.85374073116, 29359.266018349714, 30058.398832023675, 30416.847915760278, 50010.24984625161, 50400.49599503958, 50424.747876260386, 50489.74755126201, 50531.74734126306, 460019.0, 460410.0, 461446.0, 462188.0, 462474.503059635, 24290.75709242885, 24974.750252497244, 40078.99802504961, 40127.59872401355, 40391.798041010785, 42001.78999104985, 42738.145237095705, 42765.5723442774, 43022.35466468068, 43207.567924320356, 32524.674753252166, 33805.492917606745, 33908.0, 34232.31535369229, 34895.476567850994, 29382.706172937997, 33762.987110386726, 34704.0, 36071.45892811557, 36534.0, 33707.0, 34280.657193427745, 34820.65179348174, 35069.64930350664, 35361.82319088388, 26512.337191570365, 31536.053918382484, 31546.526802098448, 31581.8420907894, 31732.206694832814, 22503.549929001656, 23664.053437862294, 23926.16258431016, 23945.281641550086, 23945.64081538813], "value": 19584.424153809756, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [344.58649620455446, 366.86242659002875, 390.3091527995448, 390.46701252789944, 420.90108824426255, 15223.847761522395, 15638.296276667548, 17844.553886152837, 18643.813561864376, 19808.70286945697, 20482.078306476207, 21379.67930481044, 21393.35819925401, 21853.0, 21975.23086691966, 5306.442823503535, 5309.787608495665, 5501.642393244446, 5550.639208451458, 5558.666480011192, 5304.681719096847, 5439.456054394549, 5444.646098003617, 5446.7276636168235, 5465.562754979612, 3902.590228026059, 4094.283500387435, 4579.862604121881, 6096.939030609681, 6129.41770531801, 6124.693765311739, 6147.846303842395, 6151.569390142692, 6158.261008678987, 7635.274648908345, 7728.729494467723, 7811.33603643691, 7897.328727058207, 7910.960445197795, 7917.604119794045, 28889.711102888912, 29923.95266165674, 29974.250643733863, 30085.796568137248, 30335.0, 2783.220698204506, 2876.5786253263836, 2921.649402071765, 2928.282570770175, 2979.1658335666048, 16742.74885876713, 17421.564460888454, 17552.297908083663, 17555.47333579982, 18416.263349466004, 1612.3711752416566, 1976.545394559245, 1993.461765323369, 1993.6112458070681, 2005.2179649936536, 113670.0, 116067.83932160655, 134128.0, 134233.32883335618, 146943.69316449054, 18444.538886527946, 18487.0, 20392.184312627625, 21384.71691698472, 22596.87015649211, 40623.0, 40727.59272407238, 40873.97815054647, 40945.79527102345, 40969.590304097175, 10760.0, 10849.78300433987, 10950.616728414467, 11143.832842507369, 11181.161412894066, 8714.259287960467, 8757.781055473664, 8762.956185219033, 8898.377113602115, 8924.776880578038, 10610.628627997983, 10642.0, 11067.667969960914, 11169.609063682732, 11178.0, 3710.7959062251834, 3962.6433620973676, 4067.166230922713, 4118.176364727066, 4165.396017577495, 888.6312180445043, 901.3555307954844, 917.1195652173988, 973.7370909854442, 1058.5077938758513, 20582.015607736794, 21838.563228735653, 21935.232266870582, 21995.120195192012, 22027.66958495624, 990.9594925328377, 1026.2764750850633, 1061.7239517725448, 1067.8398240264023, 1082.3127314155568, 6743.123393958754, 10545.941676913762, 10891.747449043462, 11036.724081898017, 11419.20065595417, 546743.0, 623812.0, 632248.0, 633197.0, 634758.0, 147423.0, 150226.0, 151176.2441187787, 151590.48409515983, 153360.0, 968.7529679931713, 988.7478692933256, 1012.5038731021747, 1047.680457460497, 1050.0654417568371, 18406.53983650366, 19222.423327300203, 19358.709619356003, 19408.61182776365, 19411.320603779364, 58521.0, 59457.0, 59747.40252597592, 61130.694346527984, 61490.232939516936, 87356.5632171835, 87739.0, 89140.0, 89187.0, 89356.29827762814, 7356.595387253752, 7655.387568994578, 7667.654955526903, 7845.764627061198, 8371.330293576377, 11239.269447486215, 12389.876101238871, 13097.803532946822, 13394.598162055154, 13547.59357219285, 10831.350118992885, 11459.31244125355, 11774.646760597196, 11982.820257695967, 12098.213616114925, 10945.781084378426, 11439.714007149887, 11514.194006419806, 11757.118216133653, 12051.215416600257, 10675.359478431319, 11596.768064638829, 11973.102017348909, 12090.75818483643, 12152.453139608915, 7364.263573642593, 8129.8374032520205, 8455.055337272339, 8566.657333706582, 8708.956455217683, 8446.915530844613, 9411.623535058794, 11351.829722554334, 11669.0, 11670.0], "value": 11073.008532082742, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1424.4729450103457, 1429.228216762948, 1440.4958264607396, 1441.084911081463, 1448.0659974316563, 7885.0, 8271.214234647714, 8284.295834854045, 8285.875711864326, 8308.376871734621, 7298.452616053791, 7627.0, 7811.453198276123, 8048.517088974651, 8125.674973001088, 1938.7382703335081, 2239.6304609739414, 2241.293992392399, 2270.3075561953597, 2277.908883644652, 1748.3181559191926, 1990.6317331293758, 2176.7387913450407, 2202.8347873909443, 2278.5670722562745, 1973.2304401283511, 2052.6510493216188, 2056.085042156241, 2177.7604463509, 2245.9438514037197, 1872.7939926608062, 2246.8764217968005, 2269.387265438339, 2269.614165591853, 2284.64587988862, 2229.9665505017438, 2284.4403121235405, 2293.575688497633, 2298.367948814073, 2303.7465878753324, 7476.588787616679, 7562.810929726746, 7570.091589009354, 7573.9621301893685, 7577.962110189414, 4990.25146228065, 5108.923366149511, 5139.12634852076, 5159.922601160985, 5162.45794191612, 3271.313024264907, 3441.8795342163153, 3445.2248244145117, 3497.3704733148024, 3510.1400156961454, 1152.3374059915582, 1215.3801561203761, 1217.3487184356327, 1259.5276771210797, 1265.5191027409617, 10527.315724477885, 10568.207384446121, 10614.946925265402, 10632.734181645443, 10661.893381066246, 4357.716748411343, 4509.278515437514, 4534.841280555231, 4587.311903214544, 4593.081383723269, 9257.814843703223, 9287.628494860264, 9299.72100836976, 9321.44071355721, 9328.300377471716, 5113.616478764033, 5119.206522988943, 5139.743012849342, 5140.974295128501, 5158.09733296679, 4628.421447319085, 4633.837815676435, 4668.229742092517, 4707.411573553306, 4733.100710864925, 3726.6087060858763, 3733.8693145739767, 3791.33651610967, 3840.4431357453013, 3856.325143099946, 1252.7870262055471, 1254.1095821966505, 1256.6355756830417, 1269.847618285793, 1275.7002104505434, 758.5069704691884, 899.150302963706, 909.5952301225891, 934.7878884004127, 936.4474959773767, 5383.327084114486, 5411.227349336255, 5618.213450116987, 5693.743781529841, 5746.5977381583725, 540.5054375246606, 545.5826292885945, 558.8658721906713, 570.3697414357158, 573.5526289494201, 3678.521792167001, 3755.962440375616, 3790.1282704977457, 3795.8102094895144, 3825.8660946866726, 9028.683996060106, 9628.085331893459, 9750.0, 9773.02269773017, 9776.120149186465, 8397.958010210032, 9683.661071862593, 9693.903060969442, 9718.465484398284, 9733.610655573839, 7394.926050739424, 7759.961200194076, 7761.146273909865, 7767.262110099531, 7772.883406748903, 5514.310711161105, 5562.527185189142, 5638.4925356718095, 5675.631083979528, 5714.828555143353, 8739.475631462132, 9171.816563668555, 9197.126273004054, 9213.309001824757, 9213.861792073258, 8682.739517814476, 9070.637174512945, 9236.630534778533, 9245.445273283625, 9247.583858726239, 7022.0, 7199.928000720135, 7212.783616491513, 7221.4222862171955, 7227.9638601806655, 7763.0, 7831.765047048598, 7837.451378403457, 7841.647125879464, 7846.725364612211, 6971.3028697129885, 7025.859482810213, 7109.680064397011, 7184.497085203986, 7188.029616001772, 6938.722451102101, 6946.8610627788175, 6954.617496037767, 7026.2271150174465, 7045.26024767392, 4941.629377796751, 6295.937040629535, 6331.303556608861, 6383.39357761012, 6414.198225221848, 4888.095702295087, 4942.604591632733, 4984.925226121539, 5002.874928126826, 5089.414717307557, 4877.5366340197625, 4923.753812309442, 4996.350474438445, 5081.898362032664, 5144.6913185209005], "value": 4275.24762658657, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [279.53038894656976, 327.64614216646027, 328.05029439771874, 345.8167171399158, 374.69462388153653, 4153.56387579304, 4811.615070794337, 5170.414792603693, 5296.179092240699, 5320.749623838395, 4991.251312303148, 4996.975015124919, 5040.227874668935, 5063.924041139386, 5213.478652134785, 3262.804231746091, 3667.413213885772, 4152.5432202457705, 4168.7290326128705, 4168.9994401343765, 3395.3718562065974, 3950.940735888964, 4105.979470102645, 4114.40341150533, 4152.937705934413, 3438.742094342922, 4007.7375626677504, 4179.247735407625, 4197.916041679165, 4203.600657937491, 4165.729227600196, 4183.644390226835, 4184.033504252996, 4190.937135942963, 4335.544767799399, 2913.5286680226563, 3130.796498227608, 3701.481792549045, 3743.5320584926885, 3745.7190710696536, 4213.514026724217, 4670.089332580148, 5108.062863853299, 5125.00062487815, 5188.610854185951, 4202.516710578292, 4535.455745310551, 4797.832075877328, 4799.784009719571, 4820.734859582722, 4979.904421027368, 5601.943980560183, 5613.989481893258, 5624.437556244384, 5634.323881134249, 3251.301419821566, 4079.8980025499304, 4099.262132816092, 4103.610157035077, 4115.36211887158, 5916.7337469813965, 5943.3165186003735, 5948.821535353946, 5958.659301657092, 5964.25446819152, 3197.832791031257, 3986.0, 4059.411385349108, 4143.875683729493, 4190.057237121623, 4192.81132349045, 4205.86441660756, 4217.840093974181, 4219.346001369792, 4246.428821336125, 3855.4409610606303, 4524.298733696282, 4599.770011499479, 4650.488446270908, 4762.690425122356, 4909.968906529597, 5498.45015498447, 5618.747156377973, 5669.116655091276, 5725.942740572541, 1196.9820452693216, 1354.4717560151548, 1379.675776192594, 1383.3083458270864, 1392.0255820925393, 710.9502334836512, 814.3322475570094, 883.1786438612024, 891.4562117108559, 971.3540495570508, 4407.237105157898, 4940.283658869444, 4944.206523314316, 4962.454130045692, 4987.401511818605, 4480.686351955397, 4878.902421951541, 4926.842192084857, 5466.262054622575, 5483.835484935458, 4224.619784219435, 4409.823607055682, 4811.591014763784, 4884.633652476078, 5262.184361423985, 2583.8966441342136, 2714.217926625225, 2780.7358300961378, 2804.943901121966, 2895.6235689360246, 4559.840405585788, 5427.534565667248, 5483.806477408989, 5516.972415137899, 5764.0, 4707.152712511781, 5618.4662457066515, 5619.0, 5681.517071048925, 5695.800646977419, 5421.972890135524, 5553.028220061473, 5722.399148089474, 5729.0, 5757.769689212469, 4488.057507923372, 4999.925001124913, 5152.433232344364, 5352.919706204488, 5529.889402212014, 5039.370078740158, 5089.956558905489, 5195.454477279831, 5257.921131182959, 5475.260839786578, 4881.925976285212, 5179.559737422362, 5330.9733451332495, 5709.115087161496, 5747.166660834072, 3527.8236088194976, 3656.451532270181, 3658.9451158233182, 3680.5767336756617, 3687.852485900534, 4585.656075794262, 4863.076015557032, 5531.806386776443, 5571.607098225443, 5581.325602319369, 4953.702777833341, 5389.919151212814, 5573.303337082864, 5578.386377498553, 5580.748866300945, 4685.835995740133, 5539.916901246565, 5579.386267510652, 5589.580781441489, 5590.9440905592055, 4951.554360107608, 4982.601391888713, 5219.399769026611, 5419.783208671766, 5439.564834813126, 5330.0, 5482.342118945592, 5573.804916827891, 5586.8936331795285, 5589.273394458694, 4399.67002474822, 5270.31485906845, 5445.863853403696, 5486.670799752028, 5493.780248790164], "value": 4030.526089048892, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [652.2694582068084, 711.6299524247395, 713.137104104034, 820.9261166495015, 861.1345597674336, 15103.84896151038, 15778.684426311467, 15787.28957196926, 15795.76306355404, 15811.841881581195, 12155.270683758981, 14408.855911440882, 14431.567052988401, 14534.273286335667, 15351.385944562204, 841.188253335531, 873.0, 873.2664561768114, 873.3144481581959, 873.829603227371, 859.8065435277075, 860.3504354212561, 862.7713655881197, 863.1239292118505, 863.6372723456132, 919.6827094652334, 922.529509949927, 922.9353945223837, 923.4782347973373, 926.458022057094, 915.5971372596069, 915.7298596913927, 915.7756349694301, 917.0783362720423, 917.312015988009, 565.4797586220686, 676.6954870308381, 676.7800464848895, 676.8003438985462, 678.647103506179, 15591.532254032398, 15621.92189039059, 15649.452269170524, 15654.530364089096, 15676.529704108894, 11434.199606027581, 13598.456061757517, 13963.952703547173, 14063.156210627396, 14102.294885255696, 10983.286086404438, 11754.0, 11769.234999724991, 11808.645740627795, 11959.880401195964, 3640.908977275589, 3657.7622454540638, 3671.4492826076034, 3706.870259540903, 3810.7141964352786, 96852.0, 97573.58492452801, 97758.55603609896, 98278.0, 99672.0, 10529.684109476728, 10586.788264234827, 10589.523471443803, 10652.414117223627, 10968.890311096788, 20281.79718202799, 20329.898350508447, 21012.949352532312, 21272.680909786366, 21277.574448511252, 7453.254674532612, 7481.214472480311, 7596.430267729942, 7624.618769061524, 7743.9612801936755, 3526.717862570988, 4120.681381957745, 4194.30793919006, 4195.853145139906, 4196.265653510623, 3437.364087643794, 3555.306715190565, 3555.5022296878456, 3558.1638314995957, 3560.394732895414, 553.3525774843442, 645.2450632759683, 650.3041745332449, 683.6205905722272, 710.5523520182252, 662.3442791636342, 696.2619623199424, 696.4010950582496, 704.503325155764, 713.53263612334, 8974.730758077269, 9609.990950950189, 10108.39349639024, 10358.290882004536, 10442.947785261025, 562.9240052592847, 567.1322875999728, 570.1988705868262, 607.3076692570473, 682.2086379799409, 4111.951980696587, 4300.1399720056115, 4550.112728018004, 4565.794539245676, 4679.578837904605, 93433.5328323354, 94575.58136627956, 95558.5222073899, 96781.0, 99509.00490995143, 59401.70299148563, 63930.36069639337, 64480.35519644837, 64645.70708585802, 84587.5770621143, 61313.16060518192, 74189.62905185547, 77847.0, 78161.60919195367, 79971.20028799637, 10403.583856645952, 10725.839112413163, 10917.017468427879, 11013.504392302206, 11069.391183484664, 44400.66994975325, 45081.774591126836, 46885.06229875315, 48754.512454874995, 50021.0, 64644.353556465714, 65090.0, 65873.34126658672, 66505.66747166234, 66774.33225667682, 12403.441845116811, 12466.5013399463, 12668.429920653409, 12772.680682982627, 12832.358382081045, 14238.128668946847, 14550.41798328055, 14704.41182352694, 14847.851521484647, 15038.02252853561, 13249.470021199044, 13538.255395953318, 13540.93229533846, 13541.458341666223, 13988.0, 13275.203487790763, 13462.932685336511, 13471.0, 13568.0, 13889.37497812621, 12935.482580696667, 13616.591502254552, 13640.317984100953, 13652.726945461234, 13776.86223137796, 9229.400088994462, 11118.666440006813, 11402.030827379765, 11517.53929842797, 11773.941130294294, 9797.510124493889, 10455.94772026135, 10768.515416806105, 10768.676939691823, 10846.67459976202], "value": 7347.31253079244, "unit": "score"}], "name": "dromaeo_css", "value": 7311.888075800747, "alertThreshold": 5.0}, {"lowerIsBetter": true, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [104.0, 114.0, 113.0, 114.0, 113.0, 114.0, 113.0, 113.0, 113.0, 114.0], "value": 112.5, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [143.0, 107.0, 110.0, 148.0, 113.0, 112.0, 109.0, 110.0, 131.0, 110.0], "value": 119.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [197.0, 230.0, 257.0, 223.0, 185.0, 181.0, 184.0, 185.0, 184.0, 182.0], "value": 200.8, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [80.0, 57.0, 57.0, 94.0, 76.0, 68.0, 59.0, 59.0, 75.0, 62.0], "value": 68.7, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [92.0, 70.0, 86.0, 70.0, 68.0, 70.0, 82.0, 69.0, 70.0, 83.0], "value": 76.0, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [88.0, 85.0, 88.0, 86.0, 88.0, 84.0, 88.0, 86.0, 88.0, 85.0], "value": 86.6, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [93.0, 94.0, 94.0, 95.0, 94.0, 94.0, 95.0, 94.0, 94.0, 94.0], "value": 94.1, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [87.0, 98.0, 132.0, 87.0, 86.0, 95.0, 85.0, 88.0, 89.0, 86.0], "value": 93.3, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 52.0, 54.0, 55.0, 55.0, 55.0, 54.0, 55.0, 54.0], "value": 54.0, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 76.0, 71.0, 79.0, 73.0, 71.0, 72.0, 72.0, 73.0, 71.0], "value": 72.4, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 90.0, 87.0, 87.0, 91.0, 90.0, 89.0, 87.0, 86.0, 89.0], "value": 88.1, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [142.0, 139.0, 142.0, 139.0, 138.0, 138.0, 139.0, 141.0, 204.0, 176.0], "value": 149.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [174.0, 181.0, 176.0, 175.0, 173.0, 171.0, 173.0, 174.0, 173.0, 175.0], "value": 174.5, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [66.0, 68.0, 67.0, 68.0, 68.0, 68.0, 66.0, 67.0, 68.0, 67.0], "value": 67.3, "unit": "score"}], "name": "kraken", "value": 1457.3999999999999, "alertThreshold": 2.0}]} 04:26:51 INFO - Return code: 0 04:26:51 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 04:26:51 ERROR - # TBPL SUCCESS # 04:26:51 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:26:51 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:26:51 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:26:51 INFO - 2017-01-26 04:26:51.614 screenresolution[1953:20255] starting screenresolution argv=screenresolution get 04:26:51 INFO - 2017-01-26 04:26:51.616 screenresolution[1953:20255] Display 0: 1600x1200x32@60 04:26:51 INFO - 2017-01-26 04:26:51.623 screenresolution[1954:20258] starting screenresolution argv=screenresolution list 04:26:51 INFO - Available Modes on Display 0 04:26:51 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:26:51 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:26:51 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:26:51 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:26:51 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:26:51 INFO - Intel Iris: 04:26:51 INFO - Chipset Model: Intel Iris 04:26:51 INFO - Type: GPU 04:26:51 INFO - Bus: Built-In 04:26:51 INFO - VRAM (Dynamic, Max): 1536 MB 04:26:51 INFO - Vendor: Intel (0x8086) 04:26:51 INFO - Device ID: 0x0a2e 04:26:51 INFO - Revision ID: 0x0009 04:26:51 INFO - Displays: 04:26:51 INFO - Display: 04:26:51 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:26:51 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:26:51 INFO - Display Serial Number: 1600x1200 60 04:26:51 INFO - Main Display: Yes 04:26:51 INFO - Mirror: Off 04:26:51 INFO - Online: Yes 04:26:51 INFO - Rotation: Supported 04:26:51 INFO - Return code: 0 04:26:51 INFO - Running post-action listener: _resource_record_post_action 04:26:51 INFO - [mozharness: 2017-01-26 12:26:51.870156Z] Finished run-tests step (success) 04:26:51 INFO - Running post-run listener: _resource_record_post_run 04:26:51 INFO - Total resource usage - Wall time: 1201s; CPU: 54.0%; Read bytes: 286720; Write bytes: 551642112; Read time: 4; Write time: 1671 04:26:51 INFO - TinderboxPrint: CPU usage
53.6% 04:26:51 INFO - TinderboxPrint: I/O read bytes / time
286,720 / 4 04:26:51 INFO - TinderboxPrint: I/O write bytes / time
551,642,112 / 1,671 04:26:51 INFO - TinderboxPrint: CPU idle
2,227.9 (46.4%) 04:26:51 INFO - TinderboxPrint: CPU system
958.7 (19.9%) 04:26:51 INFO - TinderboxPrint: CPU user
1,619.1 (33.7%) 04:26:51 INFO - TinderboxPrint: Swap in / out
250,724,352 / 0 04:26:51 INFO - install - Wall time: 22s; CPU: 54.0%; Read bytes: 251810304; Write bytes: 255043584; Read time: 18186; Write time: 550 04:26:51 INFO - run-tests - Wall time: 1180s; CPU: 54.0%; Read bytes: 249856; Write bytes: 295173120; Read time: 3; Write time: 1110 04:26:52 INFO - Running post-run listener: _upload_blobber_files 04:26:52 INFO - Blob upload gear active. 04:26:52 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 04:26:52 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 04:26:52 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 04:26:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 04:26:52 INFO - (blobuploader) - INFO - Open directory for files ... 04:26:52 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 04:26:52 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:52 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:53 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 04:26:53 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:53 INFO - (blobuploader) - INFO - Done attempting. 04:26:53 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 04:26:53 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:53 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:54 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 04:26:54 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:54 INFO - (blobuploader) - INFO - Done attempting. 04:26:54 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 04:26:54 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:54 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:55 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 04:26:55 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:55 INFO - (blobuploader) - INFO - Done attempting. 04:26:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 04:26:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 04:26:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 04:26:58 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 04:26:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 04:26:58 INFO - (blobuploader) - INFO - Done attempting. 04:26:58 INFO - (blobuploader) - INFO - Iteration through files over. 04:26:58 INFO - Return code: 0 04:26:58 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 04:26:58 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 04:26:58 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d603716b6067a23bf4684e0e746e7218924449046d2ea9cac4331fc3030da3fa5e15f2976e753dc452649ed3cac7f69405fd2174b7f596ee13a3be7cedc66d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22645732488adbad7ebfd17bdad7dbcd048c82bf13f47a21de3c778e28c38ea8b26b249a6cf3394afd7789ed90fbe5200af41523f52086beb1f2c351eb519ce4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09d0182675f987a6779b4f2a0d6856522ce5ea5810ac39397d630abb2144587a0a6fc86e47cb49b09bea0d7873df02980e9ec4205cb7de95628496d23aa49e02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92d23089f33bc6458e580fe60c9d9b08f77c1b7c836ad03e34e3336972527e4e74473596a283cd3bfe2af4458bcbae5525e2ab799595d7ca3f1c55ef8eb5bb9f"} 04:26:58 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 04:26:58 INFO - Writing to file /builds/slave/test/properties/blobber_files 04:26:58 INFO - Contents: 04:26:58 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d603716b6067a23bf4684e0e746e7218924449046d2ea9cac4331fc3030da3fa5e15f2976e753dc452649ed3cac7f69405fd2174b7f596ee13a3be7cedc66d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22645732488adbad7ebfd17bdad7dbcd048c82bf13f47a21de3c778e28c38ea8b26b249a6cf3394afd7789ed90fbe5200af41523f52086beb1f2c351eb519ce4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09d0182675f987a6779b4f2a0d6856522ce5ea5810ac39397d630abb2144587a0a6fc86e47cb49b09bea0d7873df02980e9ec4205cb7de95628496d23aa49e02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92d23089f33bc6458e580fe60c9d9b08f77c1b7c836ad03e34e3336972527e4e74473596a283cd3bfe2af4458bcbae5525e2ab799595d7ca3f1c55ef8eb5bb9f"} 04:26:58 INFO - Running post-run listener: copy_logs_to_upload_dir 04:26:58 INFO - Copying logs to upload dir... 04:26:58 INFO - mkdir: /builds/slave/test/build/upload/logs 04:26:58 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1263.269981 ========= master_lag: 2.66 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 5 secs) (at 2017-01-26 04:27:00.986477) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 04:27:00.997402) ========= 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.fVyLEeaxpo/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.Gao65OeplW/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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/1d603716b6067a23bf4684e0e746e7218924449046d2ea9cac4331fc3030da3fa5e15f2976e753dc452649ed3cac7f69405fd2174b7f596ee13a3be7cedc66d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22645732488adbad7ebfd17bdad7dbcd048c82bf13f47a21de3c778e28c38ea8b26b249a6cf3394afd7789ed90fbe5200af41523f52086beb1f2c351eb519ce4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09d0182675f987a6779b4f2a0d6856522ce5ea5810ac39397d630abb2144587a0a6fc86e47cb49b09bea0d7873df02980e9ec4205cb7de95628496d23aa49e02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92d23089f33bc6458e580fe60c9d9b08f77c1b7c836ad03e34e3336972527e4e74473596a283cd3bfe2af4458bcbae5525e2ab799595d7ca3f1c55ef8eb5bb9f"} build_url:https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011168 build_url: 'https://queue.taskcluster.net/v1/task/fqqZFwEPRmKlHFXMjvG40A/artifacts/public/build/firefox-54.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1d603716b6067a23bf4684e0e746e7218924449046d2ea9cac4331fc3030da3fa5e15f2976e753dc452649ed3cac7f69405fd2174b7f596ee13a3be7cedc66d8", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/22645732488adbad7ebfd17bdad7dbcd048c82bf13f47a21de3c778e28c38ea8b26b249a6cf3394afd7789ed90fbe5200af41523f52086beb1f2c351eb519ce4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/09d0182675f987a6779b4f2a0d6856522ce5ea5810ac39397d630abb2144587a0a6fc86e47cb49b09bea0d7873df02980e9ec4205cb7de95628496d23aa49e02", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/92d23089f33bc6458e580fe60c9d9b08f77c1b7c836ad03e34e3336972527e4e74473596a283cd3bfe2af4458bcbae5525e2ab799595d7ca3f1c55ef8eb5bb9f"}' ========= master_lag: 0.10 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-01-26 04:27:01.112130) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:27:01.112435) ========= 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.fVyLEeaxpo/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.Gao65OeplW/Listeners TMPDIR=/var/folders/ls/yjsxg9nn7856g1hdz9l0735w00000w/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.005263 ========= master_lag: 0.05 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-01-26 04:27:01.170121) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 04:27:01.170409) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-01-26 04:27:01.172727) ========= ========= Total master_lag: 2.90 =========