builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0125 starttime: 1494070902.1 results: success (0) buildid: 20170506030204 builduid: 905116b528b2426f8a0f55bff1cfb8de revision: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-06 04:41:42.098999) ========= master: http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-06 04:41:42.099815) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-06 04:41:42.100346) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-06 04:41:42.225490) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-06 04:41:42.225932) ========= 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.rmjvULfCjw/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.iXtlQSgagG/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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-05-06 04:41:42-- https://hg.mozilla.org/build/tools/raw-file/default/buildfarm/utils/archiver_client.py Resolving hg.mozilla.org... 63.245.215.102, 63.245.215.25 Connecting to hg.mozilla.org|63.245.215.102|:443... connected. HTTP request sent, awaiting response... 200 Script output follows Length: 12179 (12K) [text/x-python] Saving to: 'archiver_client.py' 0K .......... . 100% 7.78M=0.001s 2017-05-06 04:41:42 (7.78 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.165936 ========= master_lag: 0.05 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-06 04:41:42.444947) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-06 04:41:42.445276) ========= 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.rmjvULfCjw/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.iXtlQSgagG/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.022501 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-06 04:41:42.494237) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-06 04:41:42.494609) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 --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 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.rmjvULfCjw/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.iXtlQSgagG/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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-05-06 04:41:42,538 truncating revision to first 12 chars 2017-05-06 04:41:42,538 Setting DEBUG logging. 2017-05-06 04:41:42,538 attempt 1/10 2017-05-06 04:41:42,538 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/37a5b7f6f101?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-06 04:41:43,062 unpacking tar archive at: mozilla-central-37a5b7f6f101/testing/mozharness/ program finished with exit code 0 elapsedTime=0.789463 ========= master_lag: 0.02 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-06 04:41:43.308021) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-06 04:41:43.308309) ========= script_repo_revision: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-06 04:41:43.308694) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-06 04:41:43.308957) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-06 04:41:43.329703) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-05-06 04:41:43.330086) ========= /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.rmjvULfCjw/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.iXtlQSgagG/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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:41:43 INFO - MultiFileLogger online at 20170506 04:41:43 in /builds/slave/test 04:41:43 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:41:43 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 04:41:43 INFO - {'append_to_log': False, 04:41:43 INFO - 'base_work_dir': '/builds/slave/test', 04:41:43 INFO - 'blob_upload_branch': 'Firefox', 04:41:43 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 04:41:43 INFO - 'branch': 'Firefox', 04:41:43 INFO - 'buildbot_json_path': 'buildprops.json', 04:41:43 INFO - 'config_files': ('talos/mac_config.py',), 04:41:43 INFO - 'default_actions': ('clobber', 04:41:43 INFO - 'read-buildbot-config', 04:41:43 INFO - 'download-and-extract', 04:41:43 INFO - 'populate-webroot', 04:41:43 INFO - 'create-virtualenv', 04:41:43 INFO - 'install', 04:41:43 INFO - 'run-tests'), 04:41:43 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 04:41:43 INFO - 'download_minidump_stackwalk': True, 04:41:43 INFO - 'download_symbols': 'ondemand', 04:41:43 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 04:41:43 INFO - 'tooltool.py': '/tools/tooltool.py', 04:41:43 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 04:41:43 INFO - '/tools/misc-python/virtualenv.py')}, 04:41:43 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 04:41:43 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 04:41:43 INFO - 'gecko_profile': False, 04:41:43 INFO - 'gecko_profile_interval': 0, 04:41:43 INFO - 'installer_path': 'installer.exe', 04:41:43 INFO - 'log_level': 'info', 04:41:43 INFO - 'log_name': 'talos', 04:41:43 INFO - 'log_to_console': True, 04:41:43 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 04:41:43 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 04:41:43 INFO - 'opt_config_files': (), 04:41:43 INFO - 'pip_index': False, 04:41:43 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:41:43 INFO - 'cmd': ('bash', 04:41:43 INFO - '-c', 04:41:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:41:43 INFO - 'enabled': True, 04:41:43 INFO - 'halt_on_failure': False, 04:41:43 INFO - 'name': 'check_screen_resolution'},), 04:41:43 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 04:41:43 INFO - 'cmd': ('bash', 04:41:43 INFO - '-c', 04:41:43 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 04:41:43 INFO - 'enabled': True, 04:41:43 INFO - 'halt_on_failure': False, 04:41:43 INFO - 'name': 'check_screen_resolution'},), 04:41:43 INFO - 'run_cmd_checks_enabled': True, 04:41:43 INFO - 'suite': 'dromaeojs', 04:41:43 INFO - 'system_bits': '32', 04:41:43 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 04:41:43 INFO - 'title': 't-yosemite-r7-0125', 04:41:43 INFO - 'tooltool_cache': '/builds/tooltool_cache', 04:41:43 INFO - 'use_talos_json': True, 04:41:43 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 04:41:43 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 04:41:43 INFO - 'work_dir': 'build'} 04:41:43 INFO - [mozharness: 2017-05-06 11:41:43.498253Z] Running clobber step. 04:41:43 INFO - Running pre-action listener: _resource_record_pre_action 04:41:43 INFO - Running main action method: clobber 04:41:43 INFO - rmtree: /builds/slave/test/build 04:41:43 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 04:41:45 INFO - Running post-action listener: _resource_record_post_action 04:41:45 INFO - [mozharness: 2017-05-06 11:41:45.592427Z] Finished clobber step (success) 04:41:45 INFO - [mozharness: 2017-05-06 11:41:45.592602Z] Running read-buildbot-config step. 04:41:45 INFO - Running pre-action listener: _resource_record_pre_action 04:41:45 INFO - Running main action method: read_buildbot_config 04:41:45 INFO - Using buildbot properties: 04:41:45 INFO - { 04:41:45 INFO - "project": "", 04:41:45 INFO - "product": "firefox", 04:41:45 INFO - "script_repo_revision": "production", 04:41:45 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 04:41:45 INFO - "repository": "", 04:41:45 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 04:41:45 INFO - "buildid": "20170506030204", 04:41:45 INFO - "stage_platform": "macosx64", 04:41:45 INFO - "basedir": "/builds/slave/test", 04:41:45 INFO - "nightly_build": "True", 04:41:45 INFO - "buildnumber": 26, 04:41:45 INFO - "slavename": "t-yosemite-r7-0125", 04:41:45 INFO - "master": "http://buildbot-master136.bb.releng.scl3.mozilla.com:8201/", 04:41:45 INFO - "platform": "yosemite_r7", 04:41:45 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 04:41:45 INFO - "branch": "mozilla-central", 04:41:45 INFO - "repo_path": "mozilla-central", 04:41:45 INFO - "revision": "37a5b7f6f101df2eb292b1b6baaf1540c9920e20", 04:41:45 INFO - "pgo_build": "False", 04:41:45 INFO - "builduid": "905116b528b2426f8a0f55bff1cfb8de", 04:41:45 INFO - "slavebuilddir": "test" 04:41:45 INFO - } 04:41:45 INFO - Found installer url https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 04:41:45 INFO - Running post-action listener: _resource_record_post_action 04:41:45 INFO - [mozharness: 2017-05-06 11:41:45.596083Z] Finished read-buildbot-config step (success) 04:41:45 INFO - [mozharness: 2017-05-06 11:41:45.596200Z] Running download-and-extract step. 04:41:45 INFO - Running pre-action listener: _resource_record_pre_action 04:41:45 INFO - Running main action method: download_and_extract 04:41:45 INFO - mkdir: /builds/slave/test/build/tests 04:41:45 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:41:45 INFO - trying https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 04:41:45 INFO - Downloading https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json to /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:41:45 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json'}, attempt #1 04:41:46 INFO - Downloaded 1325 bytes. 04:41:46 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 04:41:46 INFO - Using the following test package requirements: 04:41:46 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:46 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 04:41:46 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:41:46 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:46 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 04:41:46 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:46 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 04:41:46 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:46 INFO - u'jsshell-mac.zip'], 04:41:46 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:46 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 04:41:46 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 04:41:46 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:46 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 04:41:46 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:46 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 04:41:46 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:46 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 04:41:46 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 04:41:46 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 04:41:46 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 04:41:46 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:41:46 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:41:46 INFO - Fetch https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:41:48 INFO - Content-Length response header: 52702879 04:41:48 INFO - Bytes received: 52702879 04:42:06 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip', u'firefox-55.0a1.en-US.mac.talos.tests.zip'] for test suite category: talos 04:42:06 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 04:42:06 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 04:42:06 INFO - Fetch https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 04:42:08 INFO - Content-Length response header: 52702879 04:42:08 INFO - Bytes received: 52702879 04:42:24 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 04:42:24 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 04:42:24 INFO - Fetch https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 04:42:25 INFO - Content-Length response header: 14408697 04:42:25 INFO - Bytes received: 14408697 04:42:25 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:42:25 INFO - trying https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:42:25 INFO - Downloading https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 04:42:25 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg', 'file_name': '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg'}, attempt #1 04:42:27 INFO - Downloaded 70963547 bytes. 04:42:27 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:42:27 INFO - mkdir: /builds/slave/test/properties 04:42:27 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 04:42:27 INFO - Writing to file /builds/slave/test/properties/build_url 04:42:27 INFO - Contents: 04:42:27 INFO - build_url:https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 04:42:28 INFO - Running post-action listener: _resource_record_post_action 04:42:28 INFO - Running post-action listener: set_extra_try_arguments 04:42:28 INFO - [mozharness: 2017-05-06 11:42:28.373652Z] Finished download-and-extract step (success) 04:42:28 INFO - [mozharness: 2017-05-06 11:42:28.373775Z] Running populate-webroot step. 04:42:28 INFO - Running pre-action listener: _resource_record_pre_action 04:42:28 INFO - Running main action method: populate_webroot 04:42:28 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 04:42:28 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 04:42:28 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 04:42:28 INFO - '--tppagecycles', 04:42:28 INFO - '7'], 04:42:28 INFO - 'tests': ['tsvgm']}}, 04:42:28 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 04:42:28 INFO - 'tests': ['tresize', 'tcanvasmark']}, 04:42:28 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 04:42:28 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 04:42:28 INFO - 'tests': ['dromaeo_css', 'kraken']}, 04:42:28 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 04:42:28 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 04:42:28 INFO - 'talos_options': ['--disable-e10s'], 04:42:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:28 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 04:42:28 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 04:42:28 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 04:42:28 INFO - 'talos_options': ['--disable-e10s'], 04:42:28 INFO - 'tests': ['damp', 'tps']}, 04:42:28 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 04:42:28 INFO - 'tests': ['damp', 'tps']}, 04:42:28 INFO - 'g3': {'talos_options': ['--disable-e10s'], 04:42:28 INFO - 'tests': ['dromaeo_dom']}, 04:42:28 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 04:42:28 INFO - 'g4': {'talos_options': ['--disable-e10s'], 04:42:28 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 04:42:28 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 04:42:28 INFO - 'other': {'talos_options': ['--disable-e10s'], 04:42:28 INFO - 'tests': ['a11yr', 04:42:28 INFO - 'ts_paint', 04:42:28 INFO - 'tpaint', 04:42:28 INFO - 'sessionrestore', 04:42:28 INFO - 'sessionrestore_no_auto_restore', 04:42:28 INFO - 'tabpaint']}, 04:42:28 INFO - 'other-e10s': {'tests': ['a11yr', 04:42:28 INFO - 'ts_paint', 04:42:28 INFO - 'tpaint', 04:42:28 INFO - 'sessionrestore', 04:42:28 INFO - 'sessionrestore_no_auto_restore', 04:42:28 INFO - 'tabpaint']}, 04:42:28 INFO - 'other-e10s_l64': {'tests': ['a11yr', 04:42:28 INFO - 'ts_paint', 04:42:28 INFO - 'tpaint', 04:42:28 INFO - 'sessionrestore', 04:42:28 INFO - 'sessionrestore_no_auto_restore', 04:42:28 INFO - 'tabpaint']}, 04:42:28 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 04:42:28 INFO - 'ts_paint', 04:42:28 INFO - 'tpaint', 04:42:28 INFO - 'sessionrestore', 04:42:28 INFO - 'sessionrestore_no_auto_restore', 04:42:28 INFO - 'tabpaint']}, 04:42:28 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 04:42:28 INFO - 'tests': ['a11yr', 04:42:28 INFO - 'ts_paint', 04:42:28 INFO - 'tpaint', 04:42:28 INFO - 'sessionrestore', 04:42:28 INFO - 'sessionrestore_no_auto_restore', 04:42:28 INFO - 'tabpaint']}, 04:42:28 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 04:42:28 INFO - 'tests': ['a11yr', 04:42:28 INFO - 'ts_paint', 04:42:28 INFO - 'tpaint', 04:42:28 INFO - 'sessionrestore', 04:42:28 INFO - 'sessionrestore_no_auto_restore', 04:42:28 INFO - 'tabpaint']}, 04:42:28 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 04:42:28 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 04:42:28 INFO - 'bloom_basic_ref']}, 04:42:28 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 04:42:28 INFO - 'tests': ['tsvgx', 04:42:28 INFO - 'tsvgr_opacity', 04:42:28 INFO - 'tart', 04:42:28 INFO - 'tscrollx', 04:42:28 INFO - 'cart', 04:42:28 INFO - 'tsvg_static']}, 04:42:28 INFO - 'svgr-e10s': {'tests': ['tsvgx', 04:42:28 INFO - 'tsvgr_opacity', 04:42:28 INFO - 'tart', 04:42:28 INFO - 'tscrollx', 04:42:28 INFO - 'cart', 04:42:28 INFO - 'tsvg_static']}, 04:42:28 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 04:42:28 INFO - 'talos_options': ['--disable-e10s'], 04:42:28 INFO - 'tests': ['tp5o']}, 04:42:28 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 04:42:28 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 04:42:28 INFO - 'talos_options': ['--disable-e10s', 04:42:28 INFO - '--xperf_path', 04:42:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:28 INFO - 'tests': ['tp5n']}, 04:42:28 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 04:42:28 INFO - 'talos_options': ['--xperf_path', 04:42:28 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 04:42:28 INFO - 'tests': ['tp5n']}}, 04:42:28 INFO - 'talos.zip': {'path': '', 04:42:28 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 04:42:28 INFO - Running post-action listener: _resource_record_post_action 04:42:28 INFO - [mozharness: 2017-05-06 11:42:28.393168Z] Finished populate-webroot step (success) 04:42:28 INFO - [mozharness: 2017-05-06 11:42:28.393298Z] Running create-virtualenv step. 04:42:28 INFO - Running pre-action listener: _resource_record_pre_action 04:42:28 INFO - Running main action method: create_virtualenv 04:42:28 INFO - Creating virtualenv /builds/slave/test/build/venv 04:42:28 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:42:28 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 04:42:28 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 04:42:28 INFO - Using real prefix '/tools/python27' 04:42:28 INFO - New python executable in /builds/slave/test/build/venv/bin/python 04:42:29 INFO - Installing distribute.............................................................................................................................................................................................done. 04:42:32 INFO - Installing pip.................done. 04:42:32 INFO - Return code: 0 04:42:32 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 04:42:32 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 04:42:32 INFO - Reading from file tmpfile_stdout 04:42:32 INFO - Output received: 04:42:32 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:42:32 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 04:42:32 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:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:32 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:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:32 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 0x103282b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103285768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca2c92100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103060d30>, '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 0x102f86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055be8>, '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.rmjvULfCjw/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.iXtlQSgagG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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:42:32 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:42:32 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:42:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rmjvULfCjw/Render', 04:42:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:32 INFO - 'HOME': '/Users/cltbld', 04:42:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:32 INFO - 'LOGNAME': 'cltbld', 04:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:32 INFO - 'MOZ_NO_REMOTE': '1', 04:42:32 INFO - 'NO_EM_RESTART': '1', 04:42:32 INFO - 'PAGER': '/bin/cat', 04:42:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:32 INFO - 'PWD': '/builds/slave/test', 04:42:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:32 INFO - 'SHELL': '/bin/bash', 04:42:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iXtlQSgagG/Listeners', 04:42:32 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 04:42:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:32 INFO - 'USER': 'cltbld', 04:42:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:32 INFO - 'XPC_FLAGS': '0x0', 04:42:32 INFO - 'XPC_SERVICE_NAME': '0', 04:42:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:32 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:42:32 INFO - Cleaning up... 04:42:32 INFO - Return code: 0 04:42:32 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 04:42:32 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:42:32 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:32 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:32 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:42:32 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:32 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:32 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 0x103282b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103285768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca2c92100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103060d30>, '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 0x102f86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055be8>, '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.rmjvULfCjw/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.iXtlQSgagG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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:42:32 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:42:32 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:42:32 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rmjvULfCjw/Render', 04:42:32 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:32 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:32 INFO - 'HOME': '/Users/cltbld', 04:42:32 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:32 INFO - 'LOGNAME': 'cltbld', 04:42:32 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:32 INFO - 'MOZ_NO_REMOTE': '1', 04:42:32 INFO - 'NO_EM_RESTART': '1', 04:42:32 INFO - 'PAGER': '/bin/cat', 04:42:32 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:32 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:32 INFO - 'PWD': '/builds/slave/test', 04:42:32 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:32 INFO - 'SHELL': '/bin/bash', 04:42:32 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iXtlQSgagG/Listeners', 04:42:32 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 04:42:32 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:32 INFO - 'USER': 'cltbld', 04:42:32 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:32 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:32 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:32 INFO - 'XPC_FLAGS': '0x0', 04:42:32 INFO - 'XPC_SERVICE_NAME': '0', 04:42:32 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:32 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:32 INFO - Downloading/unpacking psutil>=3.1.1 04:42: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:42: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:42: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:42: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:42: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:42: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:42:35 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 04:42:35 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:35 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:35 INFO - Installing collected packages: psutil 04:42:35 INFO - Running setup.py install for psutil 04:42:35 INFO - building 'psutil._psutil_osx' extension 04:42:35 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:42:36 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:42:36 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:42:36 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:42:36 INFO - building 'psutil._psutil_posix' extension 04:42:36 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:42:36 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 04:42:36 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 04:42:36 INFO - ^ 04:42:36 INFO - 1 warning generated. 04:42:36 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:42:36 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 04:42:36 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 04:42:36 INFO - Successfully installed psutil 04:42:36 INFO - Cleaning up... 04:42:36 INFO - Return code: 0 04:42:36 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 04:42:36 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:42:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:36 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:42:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:36 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 0x103282b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103285768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca2c92100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103060d30>, '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 0x102f86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055be8>, '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.rmjvULfCjw/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.iXtlQSgagG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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:42:36 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:42:36 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:42:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rmjvULfCjw/Render', 04:42:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:36 INFO - 'HOME': '/Users/cltbld', 04:42:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:36 INFO - 'LOGNAME': 'cltbld', 04:42:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:36 INFO - 'MOZ_NO_REMOTE': '1', 04:42:36 INFO - 'NO_EM_RESTART': '1', 04:42:36 INFO - 'PAGER': '/bin/cat', 04:42:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:36 INFO - 'PWD': '/builds/slave/test', 04:42:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:36 INFO - 'SHELL': '/bin/bash', 04:42:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iXtlQSgagG/Listeners', 04:42:36 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 04:42:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:36 INFO - 'USER': 'cltbld', 04:42:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:36 INFO - 'XPC_FLAGS': '0x0', 04:42:36 INFO - 'XPC_SERVICE_NAME': '0', 04:42:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:36 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:36 INFO - Downloading/unpacking mozsystemmonitor==0.3 04:42: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:42: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:42: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:42: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:42: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:42: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:42:38 INFO - Downloading mozsystemmonitor-0.3.tar.gz 04:42:38 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 04:42:38 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 04:42:38 INFO - Installing collected packages: mozsystemmonitor 04:42:38 INFO - Running setup.py install for mozsystemmonitor 04:42:38 INFO - Successfully installed mozsystemmonitor 04:42:38 INFO - Cleaning up... 04:42:38 INFO - Return code: 0 04:42:38 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 04:42: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:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:38 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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:42:38 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:38 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:38 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103282b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103285768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca2c92100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103060d30>, '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 0x102f86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055be8>, '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.rmjvULfCjw/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.iXtlQSgagG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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:42:38 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'jsonschema==2.5.1'] in /builds/slave/test/build 04:42:38 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub jsonschema==2.5.1 04:42:38 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rmjvULfCjw/Render', 04:42:38 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:38 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:38 INFO - 'HOME': '/Users/cltbld', 04:42:38 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:38 INFO - 'LOGNAME': 'cltbld', 04:42:38 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:38 INFO - 'MOZ_NO_REMOTE': '1', 04:42:38 INFO - 'NO_EM_RESTART': '1', 04:42:38 INFO - 'PAGER': '/bin/cat', 04:42:38 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:38 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:38 INFO - 'PWD': '/builds/slave/test', 04:42:38 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:38 INFO - 'SHELL': '/bin/bash', 04:42:38 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iXtlQSgagG/Listeners', 04:42:38 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 04:42:38 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:38 INFO - 'USER': 'cltbld', 04:42:38 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:38 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:38 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:38 INFO - 'XPC_FLAGS': '0x0', 04:42:38 INFO - 'XPC_SERVICE_NAME': '0', 04:42:38 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:38 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:38 INFO - Downloading/unpacking jsonschema==2.5.1 04:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:38 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:38 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:38 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:38 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:40 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 04:42:40 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 04:42:40 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:42:40 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:42:40 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:42:40 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:42:40 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:42:40 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:42:40 INFO - Downloading functools32-3.2.3-2.tar.gz 04:42:40 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 04:42:40 INFO - warning: no files found matching '*.txt' 04:42:40 INFO - no previously-included directories found matching 'build' 04:42:40 INFO - no previously-included directories found matching 'dist' 04:42:40 INFO - no previously-included directories found matching '.git*' 04:42:40 INFO - Installing collected packages: jsonschema, functools32 04:42:40 INFO - Running setup.py install for functools32 04:42:40 INFO - warning: no files found matching '*.txt' 04:42:40 INFO - no previously-included directories found matching 'build' 04:42:40 INFO - no previously-included directories found matching 'dist' 04:42:40 INFO - no previously-included directories found matching '.git*' 04:42:40 INFO - Successfully installed jsonschema functools32 04:42:40 INFO - Cleaning up... 04:42:40 INFO - Return code: 0 04:42:40 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 04:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103282b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103285768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca2c92100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103060d30>, '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 0x102f86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055be8>, '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.rmjvULfCjw/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.iXtlQSgagG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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:42:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'functools32==3.2.3-2'] in /builds/slave/test/build 04:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub functools32==3.2.3-2 04:42:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rmjvULfCjw/Render', 04:42:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:40 INFO - 'HOME': '/Users/cltbld', 04:42:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:40 INFO - 'LOGNAME': 'cltbld', 04:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:40 INFO - 'MOZ_NO_REMOTE': '1', 04:42:40 INFO - 'NO_EM_RESTART': '1', 04:42:40 INFO - 'PAGER': '/bin/cat', 04:42:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:40 INFO - 'PWD': '/builds/slave/test', 04:42:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:40 INFO - 'SHELL': '/bin/bash', 04:42:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iXtlQSgagG/Listeners', 04:42:40 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 04:42:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:40 INFO - 'USER': 'cltbld', 04:42:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:40 INFO - 'XPC_FLAGS': '0x0', 04:42:40 INFO - 'XPC_SERVICE_NAME': '0', 04:42:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:40 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:40 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 04:42:40 INFO - Cleaning up... 04:42:40 INFO - Return code: 0 04:42:40 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 04:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:40 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:40 INFO - retry: Calling run_command with args: [['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', '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 0x103282b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103285768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca2c92100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103060d30>, '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 0x102f86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055be8>, '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.rmjvULfCjw/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.iXtlQSgagG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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:42:40 INFO - Running command: ['/builds/slave/test/build/venv/bin/pip', 'install', '--timeout', '120', '--no-index', '--find-links', 'http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub', '--find-links', 'http://pypi.pvt.build.mozilla.org/pub', '--find-links', 'http://pypi.pub.build.mozilla.org/pub', 'blobuploader==1.2.4'] in /builds/slave/test/build 04:42:40 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip install --timeout 120 --no-index --find-links http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub --find-links http://pypi.pvt.build.mozilla.org/pub --find-links http://pypi.pub.build.mozilla.org/pub blobuploader==1.2.4 04:42:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rmjvULfCjw/Render', 04:42:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:40 INFO - 'HOME': '/Users/cltbld', 04:42:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:40 INFO - 'LOGNAME': 'cltbld', 04:42:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:40 INFO - 'MOZ_NO_REMOTE': '1', 04:42:40 INFO - 'NO_EM_RESTART': '1', 04:42:40 INFO - 'PAGER': '/bin/cat', 04:42:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:40 INFO - 'PWD': '/builds/slave/test', 04:42:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:40 INFO - 'SHELL': '/bin/bash', 04:42:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iXtlQSgagG/Listeners', 04:42:40 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 04:42:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:40 INFO - 'USER': 'cltbld', 04:42:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:40 INFO - 'XPC_FLAGS': '0x0', 04:42:40 INFO - 'XPC_SERVICE_NAME': '0', 04:42:41 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:41 INFO - Downloading/unpacking blobuploader==1.2.4 04:42:41 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:42:41 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:42:41 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:42:41 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:42:41 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:42:41 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:42:42 INFO - Downloading blobuploader-1.2.4.tar.gz 04:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 04:42:42 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 04:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:42 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:42 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:42 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:42 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:42 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 04:42:43 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 04:42:43 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:42:43 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:42:43 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:42:43 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:42:43 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:42:43 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:42:43 INFO - Downloading docopt-0.6.1.tar.gz 04:42:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 04:42:43 INFO - Installing collected packages: blobuploader, requests, docopt 04:42:43 INFO - Running setup.py install for blobuploader 04:42:43 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 04:42:43 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 04:42:43 INFO - Running setup.py install for requests 04:42:44 INFO - Running setup.py install for docopt 04:42:44 INFO - Successfully installed blobuploader requests docopt 04:42:44 INFO - Cleaning up... 04:42:44 INFO - Return code: 0 04:42:44 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:44 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:42:44 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:44 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:42:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:44 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 0x103282b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103285768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca2c92100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103060d30>, '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 0x102f86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055be8>, '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.rmjvULfCjw/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.iXtlQSgagG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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:42:44 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:42:44 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:42:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rmjvULfCjw/Render', 04:42:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:44 INFO - 'HOME': '/Users/cltbld', 04:42:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:44 INFO - 'LOGNAME': 'cltbld', 04:42:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:44 INFO - 'MOZ_NO_REMOTE': '1', 04:42:44 INFO - 'NO_EM_RESTART': '1', 04:42:44 INFO - 'PAGER': '/bin/cat', 04:42:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:44 INFO - 'PWD': '/builds/slave/test', 04:42:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:44 INFO - 'SHELL': '/bin/bash', 04:42:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iXtlQSgagG/Listeners', 04:42:44 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 04:42:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:44 INFO - 'USER': 'cltbld', 04:42:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:44 INFO - 'XPC_FLAGS': '0x0', 04:42:44 INFO - 'XPC_SERVICE_NAME': '0', 04:42:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:44 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-47mvqB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:44 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-CNxzw1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:44 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-UCjzPf-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:44 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:44 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-WeWogO-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:45 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-uqh3_Y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:45 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-KPPivp-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:45 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-P7Wrcb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:45 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-sCKFjR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:45 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-smZqOM-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:45 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-yDKdhu-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:45 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-WKXQZD-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:45 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-oCXGx9-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:45 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:45 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-msTn1c-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:46 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-aTk3CJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:46 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-n62Z9n-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:46 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-0bHRgJ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:46 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:46 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-m4sQ6_-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:46 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 04:42:46 INFO - Running setup.py install for manifestparser 04:42:46 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 04:42:46 INFO - Running setup.py install for mozcrash 04:42:46 INFO - Running setup.py install for mozdebug 04:42:46 INFO - Running setup.py install for mozdevice 04:42:47 INFO - Installing dm script to /builds/slave/test/build/venv/bin 04:42:47 INFO - Running setup.py install for mozfile 04:42:47 INFO - Running setup.py install for mozhttpd 04:42:47 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 04:42:47 INFO - Running setup.py install for mozinfo 04:42:47 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 04:42:47 INFO - Running setup.py install for mozInstall 04:42:47 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 04:42:47 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 04:42:47 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 04:42:47 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 04:42:47 INFO - Running setup.py install for mozleak 04:42:47 INFO - Running setup.py install for mozlog 04:42:47 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 04:42:47 INFO - Running setup.py install for moznetwork 04:42:48 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 04:42:48 INFO - Running setup.py install for mozprocess 04:42:48 INFO - Running setup.py install for mozprofile 04:42:48 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 04:42:48 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 04:42:48 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 04:42:48 INFO - Running setup.py install for mozrunner 04:42:48 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 04:42:48 INFO - Running setup.py install for mozscreenshot 04:42:48 INFO - Running setup.py install for moztest 04:42:48 INFO - Running setup.py install for mozversion 04:42:49 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 04:42:49 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 04:42:49 INFO - Cleaning up... 04:42:49 INFO - Return code: 0 04:42:49 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42: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:42:49 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:49 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42: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:42:49 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:49 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:49 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 0x103282b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103285768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca2c92100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103060d30>, '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 0x102f86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055be8>, '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.rmjvULfCjw/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.iXtlQSgagG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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:42:49 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:42:49 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:42:49 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rmjvULfCjw/Render', 04:42:49 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:49 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:49 INFO - 'HOME': '/Users/cltbld', 04:42:49 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:49 INFO - 'LOGNAME': 'cltbld', 04:42:49 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:49 INFO - 'MOZ_NO_REMOTE': '1', 04:42:49 INFO - 'NO_EM_RESTART': '1', 04:42:49 INFO - 'PAGER': '/bin/cat', 04:42:49 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:49 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:49 INFO - 'PWD': '/builds/slave/test', 04:42:49 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:49 INFO - 'SHELL': '/bin/bash', 04:42:49 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iXtlQSgagG/Listeners', 04:42:49 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 04:42:49 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:49 INFO - 'USER': 'cltbld', 04:42:49 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:49 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:49 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:49 INFO - 'XPC_FLAGS': '0x0', 04:42:49 INFO - 'XPC_SERVICE_NAME': '0', 04:42:49 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:49 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 04:42:49 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-SZynxB-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 04:42:49 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:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 04:42:49 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-NH592K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 04:42:49 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:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 04:42:49 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-4I9xFU-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 04:42:49 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:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 04:42:49 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-lzKwa1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 04:42:49 INFO - Requirement already satisfied (use --upgrade to upgrade): mozdevice==0.50 from file:///builds/slave/test/build/tests/mozbase/mozdevice in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 04:42:49 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-anVyur-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 04:42:49 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:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 04:42:49 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-g_3_9D-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 04:42:49 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:42:49 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 04:42:49 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-6TLInt-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 04:42:50 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:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 04:42:50 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-pjARBR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 04:42:50 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:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 04:42:50 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-dFgmJN-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 04:42:50 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:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 04:42:50 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-B55p0V-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 04:42:50 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:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 04:42:50 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-_E48Os-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 04:42:50 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:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 04:42:50 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-gye714-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 04:42:50 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess==0.25 from file:///builds/slave/test/build/tests/mozbase/mozprocess in /builds/slave/test/build/venv/lib/python2.7/site-packages (from -r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 12)) 04:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 04:42:50 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-Udp3uj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 04:42:50 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:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 04:42:50 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-9kYyC1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 04:42:50 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:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:50 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-0NlpPz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 04:42:50 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:42:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 04:42:50 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-IE2Ty0-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 04:42:51 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:42:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 04:42:51 INFO - Running setup.py (path:/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/pip-2KKHQd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 04:42:51 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:42:51 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:42:51 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:42:51 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:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): moznetwork>=0.24 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:42:51 INFO - Requirement already satisfied (use --upgrade to upgrade): mozprocess>=0.19 in /builds/slave/test/build/venv/lib/python2.7/site-packages (from mozdevice==0.50->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 4)) 04:42:51 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 04:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:51 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:51 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 04:42:51 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 04:42:51 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 04:42:52 INFO - Downloading blessings-1.6.tar.gz 04:42:52 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 04:42:52 INFO - Installing collected packages: blessings 04:42:52 INFO - Running setup.py install for blessings 04:42:52 INFO - Successfully installed blessings 04:42:52 INFO - Cleaning up... 04:42:52 INFO - Return code: 0 04:42:52 INFO - Done creating virtualenv /builds/slave/test/build/venv. 04:42:52 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:52 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:53 INFO - Reading from file tmpfile_stdout 04:42:53 INFO - Current package versions: 04:42:53 INFO - blessings == 1.6 04:42:53 INFO - blobuploader == 1.2.4 04:42:53 INFO - docopt == 0.6.1 04:42:53 INFO - functools32 == 3.2.3-2 04:42:53 INFO - jsonschema == 2.5.1 04:42:53 INFO - manifestparser == 1.1 04:42:53 INFO - mozInstall == 1.12 04:42:53 INFO - mozcrash == 1.0 04:42:53 INFO - mozdebug == 0.1 04:42:53 INFO - mozdevice == 0.50 04:42:53 INFO - mozfile == 1.2 04:42:53 INFO - mozhttpd == 0.7 04:42:53 INFO - mozinfo == 0.9 04:42:53 INFO - mozleak == 0.1 04:42:53 INFO - mozlog == 3.4 04:42:53 INFO - moznetwork == 0.27 04:42:53 INFO - mozprocess == 0.25 04:42:53 INFO - mozprofile == 0.28 04:42:53 INFO - mozrunner == 6.13 04:42:53 INFO - mozscreenshot == 0.1 04:42:53 INFO - mozsystemmonitor == 0.3 04:42:53 INFO - moztest == 0.8 04:42:53 INFO - mozversion == 1.4 04:42:53 INFO - psutil == 3.1.1 04:42:53 INFO - requests == 1.2.3 04:42:53 INFO - wsgiref == 0.1.2 04:42:53 INFO - Installing None into virtualenv /builds/slave/test/build/venv 04:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:53 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 0x103282b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103285768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca2c92100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103060d30>, '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 0x102f86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055be8>, '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.rmjvULfCjw/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.iXtlQSgagG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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:42:53 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:42:53 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:42:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rmjvULfCjw/Render', 04:42:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:53 INFO - 'HOME': '/Users/cltbld', 04:42:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:53 INFO - 'LOGNAME': 'cltbld', 04:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:53 INFO - 'MOZ_NO_REMOTE': '1', 04:42:53 INFO - 'NO_EM_RESTART': '1', 04:42:53 INFO - 'PAGER': '/bin/cat', 04:42:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:53 INFO - 'PWD': '/builds/slave/test', 04:42:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:53 INFO - 'SHELL': '/bin/bash', 04:42:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iXtlQSgagG/Listeners', 04:42:53 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 04:42:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:53 INFO - 'USER': 'cltbld', 04:42:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:53 INFO - 'XPC_FLAGS': '0x0', 04:42:53 INFO - 'XPC_SERVICE_NAME': '0', 04:42:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:53 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:42:53 INFO - Cleaning up... 04:42:53 INFO - Return code: 0 04:42:53 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 04:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:53 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 04:42:53 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:53 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 04:42:53 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 04:42:53 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 04:42:53 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 0x103282b70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103285768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fbca2c92100>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x103060d30>, '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 0x102f86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055be8>, '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.rmjvULfCjw/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.iXtlQSgagG/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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:42:53 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:42:53 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:42:53 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rmjvULfCjw/Render', 04:42:53 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:42:53 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:42:53 INFO - 'HOME': '/Users/cltbld', 04:42:53 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:42:53 INFO - 'LOGNAME': 'cltbld', 04:42:53 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:42:53 INFO - 'MOZ_NO_REMOTE': '1', 04:42:53 INFO - 'NO_EM_RESTART': '1', 04:42:53 INFO - 'PAGER': '/bin/cat', 04:42:53 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:42:53 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:42:53 INFO - 'PWD': '/builds/slave/test', 04:42:53 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:42:53 INFO - 'SHELL': '/bin/bash', 04:42:53 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iXtlQSgagG/Listeners', 04:42:53 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 04:42:53 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:42:53 INFO - 'USER': 'cltbld', 04:42:53 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:42:53 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:42:53 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:42:53 INFO - 'XPC_FLAGS': '0x0', 04:42:53 INFO - 'XPC_SERVICE_NAME': '0', 04:42:53 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:42:53 INFO - Ignoring indexes: https://pypi.python.org/simple/ 04:42:53 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 04:42:53 INFO - Cleaning up... 04:42:53 INFO - Return code: 0 04:42:53 INFO - Running post-action listener: _resource_record_post_action 04:42:53 INFO - Running post-action listener: _start_resource_monitoring 04:42:53 INFO - Starting resource monitoring. 04:42:53 INFO - [mozharness: 2017-05-06 11:42:53.763009Z] Finished create-virtualenv step (success) 04:42:53 INFO - [mozharness: 2017-05-06 11:42:53.763868Z] Running install step. 04:42:53 INFO - Running pre-action listener: _resource_record_pre_action 04:42:53 INFO - Running main action method: install 04:42:53 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 04:42:53 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 04:42:54 INFO - Reading from file tmpfile_stdout 04:42:54 INFO - Detecting whether we're running mozinstall >=1.0... 04:42:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 04:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 04:42:54 INFO - Reading from file tmpfile_stdout 04:42:54 INFO - Output received: 04:42:54 INFO - Usage: mozinstall [options] installer 04:42:54 INFO - Options: 04:42:54 INFO - -h, --help show this help message and exit 04:42:54 INFO - -d DEST, --destination=DEST 04:42:54 INFO - Directory to install application into. [default: 04:42:54 INFO - "/builds/slave/test"] 04:42:54 INFO - --app=APP Application being installed. [default: firefox] 04:42:54 INFO - mkdir: /builds/slave/test/build/application 04:42:54 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '/builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg', '--destination', '/builds/slave/test/build/application'] 04:42:54 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg --destination /builds/slave/test/build/application 04:43:13 INFO - Reading from file tmpfile_stdout 04:43:13 INFO - Output received: 04:43:13 INFO - /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox 04:43:13 INFO - Running post-action listener: _resource_record_post_action 04:43:13 INFO - [mozharness: 2017-05-06 11:43:13.920894Z] Finished install step (success) 04:43:13 INFO - [mozharness: 2017-05-06 11:43:13.921056Z] Running run-tests step. 04:43:13 INFO - Running pre-action listener: _resource_record_pre_action 04:43:13 INFO - Running main action method: run_tests 04:43:13 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 04:43:13 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 04:43:13 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 04:43:13 INFO - 2017-05-06 04:43:13.935 screenresolution[2900:52014] starting screenresolution argv=screenresolution get 04:43:13 INFO - 2017-05-06 04:43:13.938 screenresolution[2900:52014] Display 0: 1600x1200x32@60 04:43:13 INFO - 2017-05-06 04:43:13.944 screenresolution[2901:52016] starting screenresolution argv=screenresolution list 04:43:13 INFO - Available Modes on Display 0 04:43:13 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 04:43:13 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 04:43:13 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 04:43:13 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 04:43:14 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 04:43:14 INFO - Intel Iris: 04:43:14 INFO - Chipset Model: Intel Iris 04:43:14 INFO - Type: GPU 04:43:14 INFO - Bus: Built-In 04:43:14 INFO - VRAM (Dynamic, Max): 1536 MB 04:43:14 INFO - Vendor: Intel (0x8086) 04:43:14 INFO - Device ID: 0x0a2e 04:43:14 INFO - Revision ID: 0x0009 04:43:14 INFO - Displays: 04:43:14 INFO - Display: 04:43:14 INFO - Resolution: 1600 x 1200 @ 60 Hz 04:43:14 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 04:43:14 INFO - Display Serial Number: 1600x1200 60 04:43:14 INFO - Main Display: Yes 04:43:14 INFO - Mirror: Off 04:43:14 INFO - Online: Yes 04:43:14 INFO - Rotation: Supported 04:43:14 INFO - Return code: 0 04:43:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 04:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 04:43:14 INFO - Python 2.7.3 04:43:14 INFO - Return code: 0 04:43:14 INFO - grabbing minidump binary from tooltool 04:43: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:43:14 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 0x103060d30>, '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 0x102f86db0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x103055be8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 04:43:14 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:43:14 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:43:14 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:43:14 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 04:43:14 INFO - Return code: 0 04:43:14 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 04:43:14 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 04:43:14 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 04:43:14 INFO - ENV: RUST_BACKTRACE is now 1 04:43:14 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 04:43:14 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 04:43:14 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0125', '--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:43:14 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0125 --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:43:14 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.rmjvULfCjw/Render', 04:43:14 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 04:43:14 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 04:43:14 INFO - 'HOME': '/Users/cltbld', 04:43:14 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 04:43:14 INFO - 'LOGNAME': 'cltbld', 04:43:14 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 04:43:14 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 04:43:14 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 04:43:14 INFO - 'MOZ_NO_REMOTE': '1', 04:43:14 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 04:43:14 INFO - 'NO_EM_RESTART': '1', 04:43:14 INFO - 'PAGER': '/bin/cat', 04:43:14 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 04:43:14 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 04:43:14 INFO - 'PWD': '/builds/slave/test', 04:43:14 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 04:43:14 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 04:43:14 INFO - 'RUST_BACKTRACE': '1', 04:43:14 INFO - 'SHELL': '/bin/bash', 04:43:14 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.iXtlQSgagG/Listeners', 04:43:14 INFO - 'TMPDIR': '/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/', 04:43:14 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 04:43:14 INFO - 'USER': 'cltbld', 04:43:14 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 04:43:14 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 04:43:14 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 04:43:14 INFO - 'XPC_FLAGS': '0x0', 04:43:14 INFO - 'XPC_SERVICE_NAME': '0', 04:43:14 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 04:43:14 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0125', '--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:43:14 INFO - mozversion application_buildid: 20170506030204 04:43:14 INFO - mozversion application_changeset: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 04:43:14 INFO - mozversion application_display_name: Nightly 04:43:14 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 04:43:14 INFO - mozversion application_name: Firefox 04:43:14 INFO - mozversion application_remotingname: firefox 04:43:14 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 04:43:14 INFO - mozversion application_vendor: Mozilla 04:43:14 INFO - mozversion application_version: 55.0a1 04:43:14 INFO - mozversion platform_buildid: 20170506030204 04:43:14 INFO - mozversion platform_changeset: 37a5b7f6f101df2eb292b1b6baaf1540c9920e20 04:43:14 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 04:43:14 INFO - mozversion platform_version: 55.0a1 04:43:14 INFO - using testdate: 1494070994 04:43:14 INFO - actual date: 1494070994 04:43:14 INFO - starting webserver on 'localhost:61241' 04:43:14 INFO - SUITE-START | Running 2 tests 04:43:14 INFO - TEST-START | dromaeo_css 04:43:14 INFO - operating with platform_type : mac_ 04:43:14 INFO - Initialising browser for dromaeo_css test... 04:43:14 INFO - TEST-INFO | started process 2911 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpUx3nLp/profile http://localhost:61241/getInfo.html) 04:43:17 INFO - PID 2911 | __metrics Screen width/height:1600/1200 04:43:17 INFO - PID 2911 | colorDepth:24 04:43:17 INFO - PID 2911 | Browser inner width/height: 1024/691 04:43:17 INFO - PID 2911 | __metrics 04:43:17 INFO - PID 2911 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 04:43:17 INFO - PID 2911 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 04:43:18 INFO - TEST-INFO | 2911: exit 0 04:43:18 INFO - Browser initialized. 04:43:18 INFO - Running cycle 1/1 for dromaeo_css test... 04:43:18 INFO - TEST-INFO | started process 2914 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpUx3nLp/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 04:43:30 INFO - PID 2914 | RSS: Main: 239312896 04:43:30 INFO - PID 2914 | 04:46:35 INFO - PID 2914 | Cycle 1(1): loaded http://localhost:61241/tests/dromaeo/cssquery-dojo.html (next: http://localhost:61241/tests/dromaeo/cssquery-ext.html) 04:46:37 INFO - PID 2914 | RSS: Main: 422936576 04:46:37 INFO - PID 2914 | 04:49:40 INFO - PID 2914 | Cycle 1(1): loaded http://localhost:61241/tests/dromaeo/cssquery-ext.html (next: http://localhost:61241/tests/dromaeo/cssquery-jquery.html) 04:49:40 INFO - PID 2914 | RSS: Main: 363761664 04:49:40 INFO - PID 2914 | 04:52:43 INFO - PID 2914 | Cycle 1(1): loaded http://localhost:61241/tests/dromaeo/cssquery-jquery.html (next: http://localhost:61241/tests/dromaeo/cssquery-mootools.html) 04:52:43 INFO - PID 2914 | RSS: Main: 356036608 04:52:43 INFO - PID 2914 | 04:55:46 INFO - PID 2914 | Cycle 1(1): loaded http://localhost:61241/tests/dromaeo/cssquery-mootools.html (next: http://localhost:61241/tests/dromaeo/cssquery-prototype.html) 04:55:46 INFO - PID 2914 | RSS: Main: 327110656 04:55:46 INFO - PID 2914 | 04:58:50 INFO - PID 2914 | Cycle 1(1): loaded http://localhost:61241/tests/dromaeo/cssquery-prototype.html (next: http://localhost:61241/tests/dromaeo/cssquery-yui.html) 04:58:50 INFO - PID 2914 | RSS: Main: 332976128 04:58:50 INFO - PID 2914 | 05:01:53 INFO - PID 2914 | Cycle 1(1): loaded http://localhost:61241/tests/dromaeo/cssquery-yui.html (next: http://localhost:61241/tests/dromaeo/cssquery-dojo.html) 05:01:53 INFO - PID 2914 | RSS: Main: 370421760 05:01:53 INFO - PID 2914 | 05:01:53 INFO - PID 2914 | __start_tp_report 05:01:53 INFO - PID 2914 | _x_x_mozilla_page_load 05:01:53 INFO - PID 2914 | _x_x_mozilla_page_load_details 05:01:53 INFO - PID 2914 | |i|pagename|runs| 05:01:53 INFO - PID 2914 | |0;dojo.html;3377.054424761067;3501.982490087549;3509.05255580993;3534;3587.461880717892;5492.1212605982955;5773.700917293607;6084.969575152129;6245.375462453752;6270.749170033199;6101.2170667302;6139.9828168395;6181.134641150243;6251.312355640887;6273.9686301568545;3815.67566756826;5090.669106508084;5184.611154163434;5343.492368225013;5357.919631205535;5443.101888188444;5473.397926228112;5488.259085023531;5495.422980587041;5516.089845175541;4354.716943398669;5325.467453254643;5333.040052790496;5376.086065368897;5407.270018547505;5318.946810531923;5344.251804747339;5353.625246232766;5354.196870469422;5360.2227676987;5237.8428647140645;5295.099833028395;5303.018941495836;5317.521423071942;5328.094223981932;5004.524570165829;5962.165296858443;6030.9396906030815;6032.396760323976;6049.848753781191;6397.0724244984685;6404.135441715355;6406.807795766134;6417.7753778617525;6425.45383642391;6532.738690452376;6581.605103693793;6640.83397915056;6666.866662666768;6667.966660166668;6347.52393570484;6350.587211831216;6350.9682451587905;6351.396617321393;6360.809175724736;6558.147440832757;6829.214640316427;6851.2121106072445;6855.828604284933;6884;6415.230172379251;6439.678016099177;6451.387118223761;6465.418112369815;6487.18910136233;6570.5400621956005;6572.309907459744;6575.539712220098;6589.604623722592;6593.934060659428;6447.6453795041725;6451;6457.096006559085;6458.773942911976;6470.838229044218;6353.174087368612;6392.328805475358;6450.290468048511;6469.935300646934;6495.3179916109075;5286.841394758163;5289.629725919149;5293.523582877482;5314.176302673014;5347.144456886879;4666.043461090469;4701.576858082721;4702.318163866289;4707.435107787088;4749.691270067435;6149.385061493815;6243.531735119885;6266;6347.52393570484;6415.294317625057;6619.404253617197;6655.900161497581;6661.666916654148;6671.799846004627;6688.431483323972;6338.207724034496;6360.459360954371;6375;6378.776742814072;6380;5802.2114126472125;5802.6808525531505;5836.037053886146;5840.123981402823;5861.589688721749;6593.571417857824;6667.866642667216;6802.659867006729;6869.416099631588;6899.551529150589;6456.709448074942;6495.253045899782;6715;6717.731290748316;6717.932820671731;5669.433056694297;6715.899261510984;6793.558418702769;6905.723771049303;6919.446444284345;6504.4796416285635;6504.869902601827;6504.869902602016;6530.934690653033;6549.148610680581;5394.622376433612;6491.740330386731;6646.9002964956535;6664.200295964515;6667.733290668319;5229.607779416635;6376.3623637635865;6414.647194404352;6424.550281480251;6428.517861160338;6442.452391546771;6448.193975753031;6466.838329041811;6473.352664733489;6476.967615161894;6358.554901156875;6360.586561873463;6373.8725225496155;6420.390062944013;6422.486201103994;6324.3991820776955;6407.295197528361;6424.229092508929;6438.227412710505;6503.317151699003;6334.3665633436285;6400.327965563549;6412.1023056771155;6422.967885160544;6443.581167224115 05:01:53 INFO - PID 2914 | |1;ext.html;791.8653828849095;809.6558962440963;1007.3250921882338;1108.6618581332696;1137.2096393006864;33167.502487462676;36531.08672283198;36599;36648.81675591625;36725.878300344506;38436.42345364822;38743.612563874354;38790.418143727795;38813.61186388135;38822.8058859706;5973.940260597404;8161.79595510114;8291.709790157345;8308.875366869472;8309.459885107448;6008;8185.3042491388305;8318.66725330989;8344.457610255344;8355.99728032637;8373.916260837375;8419.684586738635;8425.07324194338;8428.957855210716;8487.151284871494;5935.73289201987;8155.877661835048;8331.625076871525;8397.286230670401;8404.957975210145;5492.313460817398;5983.820485385445;6041.758329666852;6041.939580604182;8144.5113293202;36020;36278.45582316241;36284.63715362839;36339;36414.271714565824;3533.593636731783;3570.357335679577;3574.874879379235;3576;3586.5158203642436;29781.702182978326;29802.70197298021;29832.70167298321;29849.552256716168;29908.95318663858;3072.8617212225504;3146.496560550324;3162.8892988745515;3170.381775553768;3183.729383002448;274588;280414;280452;281215.99999999796;281318;37821.432678509846;38429;47585.76207118942;47778.522214777404;47930.33114701631;40035.79982100129;48490.75754621275;48874.75562622164;48941.265881011816;48984;13087.541936032194;13182;13196.538121165713;13197.604071877859;13202.141860779018;10713.196510261605;10725.731856703645;10736.033756961911;10752.516136773864;10767.138628909668;11601.477933493014;11619;11635.767284654428;11738.882611173949;11752.177347585586;5275.129603615437;5367.463253674601;5374.11327131019;5379.300690910235;5392.762003768471;947.8530827721714;972.9200587348038;1025.9025392587691;1060.4644654449453;1067.567635107767;22315.10739570399;23059.61642301467;24099.75900240975;24118;24503.877480612482;1105.4693747001484;1113.1762495753085;1138.692553010699;1149.7010777197988;1172.8447479232948;11858.584949526898;12129.150959432754;12221.755564888652;12248.632541023606;12311.876881231252;263528;303718;308372;308468;310085;49516.75241623769;49518;49552.752236238586;49621;49704;1472.5287907869379;1496.9999999999782;1543.1744016951102;1545.8840586956023;1571.088768514259;17461.650766984334;22666;22826.858657067412;23340.2997910063;28986.710132898403;40058.59941400549;48612.02775944532;48826.26760598665;48851;48934.75532622314;182722;182889;183191;183446.0827695853;183545;27683.169504914884;28041.859790700917;31953.68046319507;31986.360272793947;32104.197395065312;33371.66628333783;42484.08821602973;43061;43094.35358469563;43188.784056079516;22190.55618887581;23312.417189570395;29485.705142948296;29607.407851843273;30232.395352092393;29408.41183176367;29826.10521684353;29951.101466956025;29979.950701725335;30337;34434.96695099151;35375.58497660065;35433.46849797307;35648.10879728028;35933.820330898176;24849.378765531008;29181.70818291875;30188.69811301859;30297.93957211487;30546.84726576353;22539.43651408728;23278;23625.881870590536;23654.763452365944;23799.52400952006 05:01:53 INFO - PID 2914 | |2;jquery.html;410.49509103802325;421.6289665094718;427.08816676395884;435.790820406205;451.1608408360449;19061.61876762464;20850.791492085074;21317;21584.028718707657;21603.45991350215;21620.35138945834;21979.120835166574;22062.558748825013;22234.88882555585;22266.55466890661;5978;6248.781292654758;6251.843703907393;6271.655058971754;6274.529410294223;5878.206442130322;6074.240719910012;6117.632942023471;6196.442320191182;6200.875982480347;6090.177825993501;6155.353687862777;6163.352847950968;6165.784197553086;6179.3202747697715;5939.1388248703915;6153.784617538365;6153.876922461548;6156.076588511714;6156.6921653917125;5192.428832828386;5313.840584782462;5449;5457.890842183134;5458.426865179139;26639.733602664113;27064.729352706418;27595;27915.720842791514;28453.430931381463;2124.968125478119;2210.8784016879067;2211.3255457085584;2213.8007579317778;2214.169686367612;17747.911260443743;17848.01835899025;17911.552211194696;18313.992730399823;18575.44273671792;2127.7872212778752;2127.9680804787786;2185.595664802017;2187.726534183227;2187.9234226801987;143273;145042.27478862644;146810.99999999892;146862;147285;11769.646910592695;12207.511699531919;12264.81602775959;12270.202436841577;12273.509059637692;15719.842801572067;15765.290561924512;16110.275037623334;16381.508554743377;16391.754123688155;8724.214820666171;8842.071582483746;8943.284537237136;8989.775255618531;9051.683191088281;8405.915940840514;8422.368322375847;8433.325333973391;8582;8610.61252243638;7579.962100189574;7690.730824421118;7721.498102623312;7722.652480638385;7756.418268629763;1857.9721304180448;2169.5680850638505;2190.89045547722;2193.5283913958574;2339.9766002340098;952.6713283917038;956.5221732423422;956.7608097975506;983.439439519467;1006.1196453103535;20157;20514.38456846297;20580.897095514727;20733.905771226644;20820.37538873836;980.4754456365953;990.8753564704112;1007.450939238117;1016.4511163971521;1017.1405162637559;10326.657534520464;10527.894721052844;10537.683869483928;10569.048785609179;10626.89373106259;530269;538222;544561;551473;551677;89124;118521;126161;126457;128288.35855820662;1132.3602164776876;1139.8658334956606;1193.4754043293144;1252.8371311729418;1254.1283807753707;20533;20727.8963605181;20937.790622093584;21006.159753610296;21103.8944805275;52994.73502632462;54055.72972135271;55114;55310.72344638251;55722.72138639281;43301.783491082344;74115.88826167503;77121.84317235133;77339.61330193539;78630;8177.000503522181;8320.625571849403;8325.750227493185;8816.86774698393;8819.029906710128;10538.736531586772;12951.417186226454;13255.867441325463;13661;13721.313934303445;11047.779044419227;11134;11398.94300528492;11434.913683200082;11601.76796464049;8624.396292259482;10284.742881428025;10762.031417172491;10896.836547451952;11112.610653750684;9724;10203.897961020295;11867.991220746333;12082.879171208175;12178.817317740064;8446.788830279047;8534.78663033429;8674.826503470022;8696.652133914826;8922.955385223033;11654.88345116538;11835.81641835844;11900.63142738596;11924.642260732191;11926.582569610022 05:01:53 INFO - PID 2914 | |3;mootools.html;1191.3507138609457;1387.535175716135;1411.1674112273756;1426.465075596652;1453.360521370597;9640;10050.94465081166;10944.890551094486;11448.508204997472;11596.884031159685;11260.324380537173;11359.659210223686;11369.09047276218;11390.886091139108;11394.031507321888;2105.3683894831565;2446.865422401772;2487.0797804812246;2492.015653816741;2506.3608779761134;2004.4587961250454;2059.8455115866295;2152.1499007891875;2472.468419289852;2490.7260201377835;2450.13020377766;2479.466914613358;2484.1181380609896;2484.3664865459373;2484.7391023942496;2146.720926279589;2152.9784702152933;2319.85167342165;2416;2461.0893969231497;2431.6474111253947;2440.023990403835;2446.3028037009544;2451.521953219123;2451.9264422067367;11184.496697648545;11495.885041149566;11496;11525.42372881361;11557.826632600518;5517.5585953123655;6322.87354252917;6545.37818907203;6564.737410503574;6583.506237032242;3952.4664170336923;4143.047099167178;4261.722988005769;4279.079997800488;4284.464441944757;1232.1498166265249;1261.1550261324935;1301.6745813546613;1302.9804552931714;1308.613958882132;16407.261673224733;16412.261448234978;16439.506814795575;16455.09496977666;16455.177241137895;5450.5639548836;5641.351244606841;5853.443922827325;5869.882602347929;5928.288605367384;13549.864501355058;13552.254625995665;13561.254131022692;13575.932120339336;13589.252591107386;6538.542302038907;6676.965070414093;6683.365080317362;6693.765718199937;6700.731970721214;5974.551908606872;6169.753209871645;6191.9690401548605;6192.380761923771;6217.098520714561;3562.340966921128;3851.691864650821;3936.3505021671103;3936.881893543198;4329.220740266782;1243.198137201518;1252.3550371558472;1272.783626783449;1272.821804947308;1284.6338793443824;789.9249571290718;801.8373358630009;814.9470284431493;820.2658620534708;849.2229609906866;6434.7104380303;6436.581622194542;6607.306232845578;6711.328867113347;6852.828679282959;707.6072779607265;741.2513361504919;890.9331800115017;892.4199270474244;906.805036917066;3164.0666003529013;3755.0424641716736;3763.6074652378793;3941.5270167580074;4166.395872598457;14569.125852448888;14888.553343399715;15050.849491504945;15051.623709407353;15174.089554626758;12105.334206618545;14925.88055895812;14944;14958.925205374122;14974.326155323037;8111.553864537507;8610.61252243638;8637.784055398666;8648.43785153963;8667.566621668891;6735.4611631070375;6769.661516924232;6804.319568043156;6997.4052205561065;7023.157221133497;13144.671383215496;13439.193648381128;13543.119697219649;13590.79613805774;13664.863351366359;13190.802137967747;13438.328083595976;13696.3836627354;13781.931090344484;13791.172529648253;9267.258619310574;9419.293552983416;9434.198093162158;9435.952820235854;9440.48077355752;8534.74395768128;10616.734581635521;10696.732581685521;10731.195160362848;10743.623973160902;8930.687425940061;9027;9058.184763371328;9117.316201284797;9257.120573545502;8785.428947118417;8899.15458031486;8980.685676001309;8992.640294388151;9150.816983660423;6430.903536447051;7678.577678227751;8079.313258372869;8089.9191008089165;8109.107998120084;5971.910421343597;6086.452219300284;6099.329073801967;6137.570370074052;6170.5372097092;6034.849128771816;6096.756129754937;6149.41580549847;6197.938020619917;6233.532485063548 05:01:53 INFO - PID 2914 | |4;prototype.html;375.56059410489723;377.83752986215916;383.38849534991687;387.0343492985003;391.49301654357606;5149.716765577892;5720.199172115902;5884.205632239647;5895.174675545421;5918.585699001072;5165.915157816863;5623;5629.831105066844;5807;5857.147137848717;4458;4459.076013108476;4463.9553604463945;4467.374567560544;4469.971906461516;3688.409854423293;4456.9777151114195;4496.190685676577;4505.098980203956;4508.233600287943;3756.5492140943124;4252.447181866369;4336.176126535964;4458.910821783563;4480.97759511202;3834.789086600236;4383.517813040563;4393;4411.073674528353;4424.672598220521;3050.1154665147083;3432.622411534729;3903.707221958336;3917.784521851297;3921.3529767588598;5359.356877174764;5368.32895888014;5519;5658.547316214693;5804.419558044204;4426.313921342197;4461.620762235214;5291.576673866081;5337.919931201035;5390.460953904618;5477.946319723415;5717.456841600041;6221.3156552779155;6231.532635052389;6257.124002639634;3989.0426297688637;4213.883320919958;4425.269830477967;4439.64482841372;4480.955190448119;6390.265119511269;6518.120053792724;6536.673166341711;6657.533972621918;6687.933120668828;4260.786960651955;4329.545397733255;4574.611158051536;4576.954230457719;4581.312803079565;3568.57177138745;4530.474488783032;4549.862534366408;4598.747068911175;4807.687500312539;5126.6923984561045;5373.11343628297;5401.189821526802;5417.702026388586;5438.7280635968045;5064.848054558369;6341.397567231198;6364.872702545923;6371.840703982438;6393.520485963571;1547.636305468214;1621.570283874774;1645.3007471824667;1647;1649.2743192995044;1018.4602160854758;1115.9553617855356;1141.9885801141882;1143.1940481960198;1144.296257801446;5966.492848107872;6012.879742405127;6022.819315420545;6030.396960303934;6063.878722425527;5441.918371224435;6144.938550614526;6497.967510162419;6517.837054073686;6545.280019197884;5811.88376232473;5838.824835254949;5955.196048533479;5998.400159984054;6081.361457046946;3121.4693502104697;3184.251700850298;3329.716974057232;3371.275175837207;3422.4524076147695;5146.459621739664;6190.783322583688;6600.646867392173;6769;6803.081583986197;5910.6707682473425;6324.462420694293;6737.3599508046655;6776.898346524707;6836.760713375008;5089.974550127374;5952.7321270542925;6253.96873015632;6711.136459444122;6820.612785525027;5652.378238393691;5720.599558030898;6064.636121832704;6391.744330226739;6412.487001039813;5340.946590534045;5789.594728368974;6094;6434.195725534309;6495.577787443801;6394;6477.676116194266;6757.797266082025;6785.59286442815;6794.490413219127;4137.296659567821;4445.222086134849;4693.6949098308505;4704.88280273885;4730.432348118248;6317.241930968313;6579.835504112435;6588.637624930675;6611.404973552403;6616.5368424211765;4966.751662416792;6249.531435083208;6284.748610055546;6295.622262664255;6351.9047214290895;5241.895162096813;5524.4199359068325;6133.601315914451;6344.206974128234;6345.857745605836;5292.52367286946;5700.800471983461;6035.9094613579955;6103.298120716175;6203.534734894991;5603.915941260966;6311.368863113836;6324.406993132793;6363.96818015907;6373.171487706569;5047.4700156484505;5671.838626849547;6142.055645205653;6159.753609855556;6164.969175154096 05:01:53 INFO - PID 2914 | |5;yui.html;713.4684659928354;821.2567626298202;846.8052347959965;853.398354160317;859.1923591823685;16054.197290135506;16380.590485237844;16403.4258800942;16447.917760411197;16494.340226390945;15216;16756.748648770277;17649.55876103098;17867.642647147048;17927.924324540505;980.901909809017;987.5901500877127;988.3229987458614;989.0208693393524;990.2424645146468;1030.0008991278448;1030.6701855406272;1030.7732298894232;1031.767852233249;1034.4258936290355;1073.2272763610188;1074.1514203779004;1074.6829685242833;1075.1130317488064;1079.4063265204145;1048.130052056791;1059.3061544688203;1066.3282132256668;1071.4107241017448;1075.5267682219799;778.9182135875708;782.1865260129458;782.2529484342439;782.9021372328459;784.4979213303491;15521.301541430663;15736.68526629461;17126.400575979904;17307.653846923116;17325.653486930318;16500.17499125039;16546.172691365384;16912.661746764996;17191.82808171927;17462.825371746247;13956.371963261678;14147.575572732834;14193.361298741582;14335.139891606537;14408.06347587414;3523.594786599548;3547;3548.5741710994844;3549.2901419715904;3550.343186510504;90718.63922041241;137056;137478;138220;140084;10602.310849794738;11163.665090047312;11281.605143819927;11611.593594224161;11968.760624787456;24960.625590616157;25722.48555028889;26060.348491287492;26096.478070438865;26448.603270950953;7518.173000969889;7686.192949740197;8063.354931605458;8107.797305067421;8111.432199746079;3913.4325522799036;3989.6608788253325;3990.2817492851564;3992.4210989406956;3996.300647386696;4165.8958526037095;4208.263553878059;4256.765877876746;4257.254980378421;4319.827206911688;920.2591913509689;925.6251218256617;943.8725772020827;948.3551185193996;948.6300342866288;639.763287583597;649.3863299182227;659.7492952677952;660.6663634864362;680.625655889259;10262.715154652422;10801.83797243042;12009.159358844798;12090.879091209152;12132.029437644967;647.0552992630812;655.0599889159072;656.7274581048907;658.2463079773728;682.5699809120223;5411.702356370359;5546.58400619947;5568.470995255444;5572.136318870582;5676.403977582377;82126.58936705279;94990.57514137293;100021;109316;109334.53853756306;87098.56450717706;90777.54611227034;93753.5312323434;94573;96084.02865613053;58249.417505825244;81868;84993.15006849852;85493.14506854852;85613.28773424496;10504.42225677595;10970.286931349438;11121.94439027832;11258.930401611833;11491.253068550517;38792.61207388003;39157.41263881101;39298;41257.38113928233;41619.843634400386;69259.65370173116;71910.64044679744;72596.63701681458;74921.25078749143;76185.17561469947;15601.375944962529;16381.689464842546;16510.257038433057;16724;16962.83037169662;17075.573110672332;17157.57106072358;17693.292268309637;17975.191116400056;18822.905885470485;16417.343306268092;16690.916545417196;17303.30786768515;17433.912830435765;17550.912245438692;16615.3353865844;17191.914040429718;17351.13244337753;17421.651566968336;17505.82494175093;16167.595810104842;16649.667006659558;16766.993980361218;16847.326106955585;16977.830221697626;10920.453977301262;11678.88321116778;11981.64055078349;12113.636590902288;12381.876181238433;11664.533418663159;12833.614991550268;13002.739945201232;13040.804387933998;13079.542216022393 05:01:53 INFO - PID 2914 | __end_tp_report 05:01:53 INFO - PID 2914 | __start_cc_report 05:01:53 INFO - PID 2914 | _x_x_mozilla_cycle_collect,2021 05:01:53 INFO - PID 2914 | __end_cc_report 05:01:53 INFO - PID 2914 | __startTimestamp1494072113342__endTimestamp 05:01:53 INFO - PID 2914 | 05:01:53 INFO - PID 2914 | ------- Summary: start ------- 05:01:53 INFO - PID 2914 | Number of tests: 6 05:01:53 INFO - PID 2914 | 05:01:53 INFO - PID 2914 | [#0] dojo.html Cycles:165 Average:6051.45 Median:6378.78 stddev:746.52 (11.7%) stddev-sans-first:718.72 05:01:53 INFO - PID 2914 | Values: 3377.1 3502.0 3509.1 3534.0 3587.5 5492.1 5773.7 6085.0 6245.4 6270.7 6101.2 6140.0 6181.1 6251.3 6274.0 3815.7 5090.7 5184.6 5343.5 5357.9 5443.1 5473.4 5488.3 5495.4 5516.1 4354.7 5325.5 5333.0 5376.1 5407.3 5318.9 5344.3 5353.6 5354.2 5360.2 5237.8 5295.1 5303.0 5317.5 5328.1 5004.5 5962.2 6030.9 6032.4 6049.8 6397.1 6404.1 6406.8 6417.8 6425.5 6532.7 6581.6 6640.8 6666.9 6668.0 6347.5 6350.6 6351.0 6351.4 6360.8 6558.1 6829.2 6851.2 6855.8 6884.0 6415.2 6439.7 6451.4 6465.4 6487.2 6570.5 6572.3 6575.5 6589.6 6593.9 6447.6 6451.0 6457.1 6458.8 6470.8 6353.2 6392.3 6450.3 6469.9 6495.3 5286.8 5289.6 5293.5 5314.2 5347.1 4666.0 4701.6 4702.3 4707.4 4749.7 6149.4 6243.5 6266.0 6347.5 6415.3 6619.4 6655.9 6661.7 6671.8 6688.4 6338.2 6360.5 6375.0 6378.8 6380.0 5802.2 5802.7 5836.0 5840.1 5861.6 6593.6 6667.9 6802.7 6869.4 6899.6 6456.7 6495.3 6715.0 6717.7 6717.9 5669.4 6715.9 6793.6 6905.7 6919.4 6504.5 6504.9 6504.9 6530.9 6549.1 5394.6 6491.7 6646.9 6664.2 6667.7 5229.6 6376.4 6414.6 6424.6 6428.5 6442.5 6448.2 6466.8 6473.4 6477.0 6358.6 6360.6 6373.9 6420.4 6422.5 6324.4 6407.3 6424.2 6438.2 6503.3 6334.4 6400.3 6412.1 6423.0 6443.6 05:01:53 INFO - PID 2914 | 05:01:53 INFO - PID 2914 | [#1] ext.html Cycles:180 Average:40427.12 Median:3166.64 stddev:67951.78 (2145.9%) stddev-sans-first:68077.24 05:01:53 INFO - PID 2914 | Values: 791.9 809.7 1007.3 1108.7 1137.2 33167.5 36531.1 36599.0 36648.8 36725.9 38436.4 38743.6 38790.4 38813.6 38822.8 5973.9 8161.8 8291.7 8308.9 8309.5 6008.0 8185.3 8318.7 8344.5 8356.0 8373.9 8419.7 8425.1 8429.0 8487.2 5935.7 8155.9 8331.6 8397.3 8405.0 5492.3 5983.8 6041.8 6041.9 8144.5 36020.0 36278.5 36284.6 36339.0 36414.3 3533.6 3570.4 3574.9 3576.0 3586.5 29781.7 29802.7 29832.7 29849.6 29909.0 3072.9 3146.5 3162.9 3170.4 3183.7 274588.0 280414.0 280452.0 281216.0 281318.0 37821.4 38429.0 47585.8 47778.5 47930.3 40035.8 48490.8 48874.8 48941.3 48984.0 13087.5 13182.0 13196.5 13197.6 13202.1 10713.2 10725.7 10736.0 10752.5 10767.1 11601.5 11619.0 11635.8 11738.9 11752.2 5275.1 5367.5 5374.1 5379.3 5392.8 947.9 972.9 1025.9 1060.5 1067.6 22315.1 23059.6 24099.8 24118.0 24503.9 1105.5 1113.2 1138.7 1149.7 1172.8 11858.6 12129.2 12221.8 12248.6 12311.9 263528.0 303718.0 308372.0 308468.0 310085.0 49516.8 49518.0 49552.8 49621.0 49704.0 1472.5 1497.0 1543.2 1545.9 1571.1 17461.7 22666.0 22826.9 23340.3 28986.7 40058.6 48612.0 48826.3 48851.0 48934.8 182722.0 182889.0 183191.0 183446.1 183545.0 27683.2 28041.9 31953.7 31986.4 32104.2 33371.7 42484.1 43061.0 43094.4 43188.8 22190.6 23312.4 29485.7 29607.4 30232.4 29408.4 29826.1 29951.1 29980.0 30337.0 34435.0 35375.6 35433.5 35648.1 35933.8 24849.4 29181.7 30188.7 30297.9 30546.8 22539.4 23278.0 23625.9 23654.8 23799.5 05:01:53 INFO - PID 2914 | 05:01:53 INFO - PID 2914 | [#2] jquery.html Cycles:180 Average:34446.58 Median:2212.56 stddev:91617.58 (4140.8%) stddev-sans-first:91838.95 05:01:53 INFO - PID 2914 | Values: 410.5 421.6 427.1 435.8 451.2 19061.6 20850.8 21317.0 21584.0 21603.5 21620.4 21979.1 22062.6 22234.9 22266.6 5978.0 6248.8 6251.8 6271.7 6274.5 5878.2 6074.2 6117.6 6196.4 6200.9 6090.2 6155.4 6163.4 6165.8 6179.3 5939.1 6153.8 6153.9 6156.1 6156.7 5192.4 5313.8 5449.0 5457.9 5458.4 26639.7 27064.7 27595.0 27915.7 28453.4 2125.0 2210.9 2211.3 2213.8 2214.2 17747.9 17848.0 17911.6 18314.0 18575.4 2127.8 2128.0 2185.6 2187.7 2187.9 143273.0 145042.3 146811.0 146862.0 147285.0 11769.6 12207.5 12264.8 12270.2 12273.5 15719.8 15765.3 16110.3 16381.5 16391.8 8724.2 8842.1 8943.3 8989.8 9051.7 8405.9 8422.4 8433.3 8582.0 8610.6 7580.0 7690.7 7721.5 7722.7 7756.4 1858.0 2169.6 2190.9 2193.5 2340.0 952.7 956.5 956.8 983.4 1006.1 20157.0 20514.4 20580.9 20733.9 20820.4 980.5 990.9 1007.5 1016.5 1017.1 10326.7 10527.9 10537.7 10569.0 10626.9 530269.0 538222.0 544561.0 551473.0 551677.0 89124.0 118521.0 126161.0 126457.0 128288.4 1132.4 1139.9 1193.5 1252.8 1254.1 20533.0 20727.9 20937.8 21006.2 21103.9 52994.7 54055.7 55114.0 55310.7 55722.7 43301.8 74115.9 77121.8 77339.6 78630.0 8177.0 8320.6 8325.8 8816.9 8819.0 10538.7 12951.4 13255.9 13661.0 13721.3 11047.8 11134.0 11398.9 11434.9 11601.8 8624.4 10284.7 10762.0 10896.8 11112.6 9724.0 10203.9 11868.0 12082.9 12178.8 8446.8 8534.8 8674.8 8696.7 8923.0 11654.9 11835.8 11900.6 11924.6 11926.6 05:01:53 INFO - PID 2914 | 05:01:53 INFO - PID 2914 | [#3] mootools.html Cycles:180 Average:7047.51 Median:3759.32 stddev:4522.08 (120.3%) stddev-sans-first:4513.36 05:01:53 INFO - PID 2914 | Values: 1191.4 1387.5 1411.2 1426.5 1453.4 9640.0 10050.9 10944.9 11448.5 11596.9 11260.3 11359.7 11369.1 11390.9 11394.0 2105.4 2446.9 2487.1 2492.0 2506.4 2004.5 2059.8 2152.1 2472.5 2490.7 2450.1 2479.5 2484.1 2484.4 2484.7 2146.7 2153.0 2319.9 2416.0 2461.1 2431.6 2440.0 2446.3 2451.5 2451.9 11184.5 11495.9 11496.0 11525.4 11557.8 5517.6 6322.9 6545.4 6564.7 6583.5 3952.5 4143.0 4261.7 4279.1 4284.5 1232.1 1261.2 1301.7 1303.0 1308.6 16407.3 16412.3 16439.5 16455.1 16455.2 5450.6 5641.4 5853.4 5869.9 5928.3 13549.9 13552.3 13561.3 13575.9 13589.3 6538.5 6677.0 6683.4 6693.8 6700.7 5974.6 6169.8 6192.0 6192.4 6217.1 3562.3 3851.7 3936.4 3936.9 4329.2 1243.2 1252.4 1272.8 1272.8 1284.6 789.9 801.8 814.9 820.3 849.2 6434.7 6436.6 6607.3 6711.3 6852.8 707.6 741.3 890.9 892.4 906.8 3164.1 3755.0 3763.6 3941.5 4166.4 14569.1 14888.6 15050.8 15051.6 15174.1 12105.3 14925.9 14944.0 14958.9 14974.3 8111.6 8610.6 8637.8 8648.4 8667.6 6735.5 6769.7 6804.3 6997.4 7023.2 13144.7 13439.2 13543.1 13590.8 13664.9 13190.8 13438.3 13696.4 13781.9 13791.2 9267.3 9419.3 9434.2 9436.0 9440.5 8534.7 10616.7 10696.7 10731.2 10743.6 8930.7 9027.0 9058.2 9117.3 9257.1 8785.4 8899.2 8980.7 8992.6 9150.8 6430.9 7678.6 8079.3 8089.9 8109.1 5971.9 6086.5 6099.3 6137.6 6170.5 6034.8 6096.8 6149.4 6197.9 6233.5 05:01:53 INFO - PID 2914 | 05:01:53 INFO - PID 2914 | [#4] prototype.html Cycles:180 Average:5090.33 Median:5564.17 stddev:1548.76 (27.8%) stddev-sans-first:1512.14 05:01:53 INFO - PID 2914 | Values: 375.6 377.8 383.4 387.0 391.5 5149.7 5720.2 5884.2 5895.2 5918.6 5165.9 5623.0 5629.8 5807.0 5857.1 4458.0 4459.1 4464.0 4467.4 4470.0 3688.4 4457.0 4496.2 4505.1 4508.2 3756.5 4252.4 4336.2 4458.9 4481.0 3834.8 4383.5 4393.0 4411.1 4424.7 3050.1 3432.6 3903.7 3917.8 3921.4 5359.4 5368.3 5519.0 5658.5 5804.4 4426.3 4461.6 5291.6 5337.9 5390.5 5477.9 5717.5 6221.3 6231.5 6257.1 3989.0 4213.9 4425.3 4439.6 4481.0 6390.3 6518.1 6536.7 6657.5 6687.9 4260.8 4329.5 4574.6 4577.0 4581.3 3568.6 4530.5 4549.9 4598.7 4807.7 5126.7 5373.1 5401.2 5417.7 5438.7 5064.8 6341.4 6364.9 6371.8 6393.5 1547.6 1621.6 1645.3 1647.0 1649.3 1018.5 1116.0 1142.0 1143.2 1144.3 5966.5 6012.9 6022.8 6030.4 6063.9 5441.9 6144.9 6498.0 6517.8 6545.3 5811.9 5838.8 5955.2 5998.4 6081.4 3121.5 3184.3 3329.7 3371.3 3422.5 5146.5 6190.8 6600.6 6769.0 6803.1 5910.7 6324.5 6737.4 6776.9 6836.8 5090.0 5952.7 6254.0 6711.1 6820.6 5652.4 5720.6 6064.6 6391.7 6412.5 5340.9 5789.6 6094.0 6434.2 6495.6 6394.0 6477.7 6757.8 6785.6 6794.5 4137.3 4445.2 4693.7 4704.9 4730.4 6317.2 6579.8 6588.6 6611.4 6616.5 4966.8 6249.5 6284.7 6295.6 6351.9 5241.9 5524.4 6133.6 6344.2 6345.9 5292.5 5700.8 6035.9 6103.3 6203.5 5603.9 6311.4 6324.4 6364.0 6373.2 5047.5 5671.8 6142.1 6159.8 6165.0 05:01:53 INFO - PID 2914 | 05:01:53 INFO - PID 2914 | [#5] yui.html Cycles:180 Average:22121.75 Median:17600.24 stddev:31449.89 (178.7%) stddev-sans-first:31497.03 05:01:53 INFO - PID 2914 | Values: 713.5 821.3 846.8 853.4 859.2 16054.2 16380.6 16403.4 16447.9 16494.3 15216.0 16756.7 17649.6 17867.6 17927.9 980.9 987.6 988.3 989.0 990.2 1030.0 1030.7 1030.8 1031.8 1034.4 1073.2 1074.2 1074.7 1075.1 1079.4 1048.1 1059.3 1066.3 1071.4 1075.5 778.9 782.2 782.3 782.9 784.5 15521.3 15736.7 17126.4 17307.7 17325.7 16500.2 16546.2 16912.7 17191.8 17462.8 13956.4 14147.6 14193.4 14335.1 14408.1 3523.6 3547.0 3548.6 3549.3 3550.3 90718.6 137056.0 137478.0 138220.0 140084.0 10602.3 11163.7 11281.6 11611.6 11968.8 24960.6 25722.5 26060.3 26096.5 26448.6 7518.2 7686.2 8063.4 8107.8 8111.4 3913.4 3989.7 3990.3 3992.4 3996.3 4165.9 4208.3 4256.8 4257.3 4319.8 920.3 925.6 943.9 948.4 948.6 639.8 649.4 659.7 660.7 680.6 10262.7 10801.8 12009.2 12090.9 12132.0 647.1 655.1 656.7 658.2 682.6 5411.7 5546.6 5568.5 5572.1 5676.4 82126.6 94990.6 100021.0 109316.0 109334.5 87098.6 90777.5 93753.5 94573.0 96084.0 58249.4 81868.0 84993.2 85493.1 85613.3 10504.4 10970.3 11121.9 11258.9 11491.3 38792.6 39157.4 39298.0 41257.4 41619.8 69259.7 71910.6 72596.6 74921.3 76185.2 15601.4 16381.7 16510.3 16724.0 16962.8 17075.6 17157.6 17693.3 17975.2 18822.9 16417.3 16690.9 17303.3 17433.9 17550.9 16615.3 17191.9 17351.1 17421.7 17505.8 16167.6 16649.7 16767.0 16847.3 16977.8 10920.5 11678.9 11981.6 12113.6 12381.9 11664.5 12833.6 13002.7 13040.8 13079.5 05:01:53 INFO - PID 2914 | -------- Summary: end -------- 05:01:53 INFO - PID 2914 | 05:01:54 INFO - TEST-INFO | 2914: exit 0 05:01:54 INFO - TEST-OK | dromaeo_css | took 1119514ms 05:01:54 INFO - TEST-START | kraken 05:01:54 INFO - operating with platform_type : mac_ 05:01:54 INFO - Initialising browser for kraken test... 05:01:54 INFO - TEST-INFO | started process 2918 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpnTjoO2/profile http://localhost:61241/getInfo.html) 05:01:56 INFO - PID 2918 | __metrics Screen width/height:1600/1200 05:01:56 INFO - PID 2918 | colorDepth:24 05:01:56 INFO - PID 2918 | Browser inner width/height: 1024/691 05:01:56 INFO - PID 2918 | __metrics 05:01:56 INFO - PID 2918 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 05:01:56 INFO - PID 2918 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 05:01:57 INFO - TEST-INFO | 2918: exit 0 05:01:57 INFO - Browser initialized. 05:01:57 INFO - Running cycle 1/1 for kraken test... 05:01:57 INFO - TEST-INFO | started process 2920 (/builds/slave/test/build/application/FirefoxNightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/T/tmpnTjoO2/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 05:02:10 INFO - PID 2920 | RSS: Main: 239476736 05:02:10 INFO - PID 2920 | 05:02:12 INFO - PID 2920 | Cycle 1(1): loaded http://localhost:61241/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:61241/tests/kraken/driver.html?testName=audio-beat-detection) 05:02:13 INFO - PID 2920 | RSS: Main: 308170752 05:02:13 INFO - PID 2920 | 05:02:16 INFO - PID 2920 | Cycle 1(1): loaded http://localhost:61241/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:61241/tests/kraken/driver.html?testName=audio-dft) 05:02:17 INFO - PID 2920 | RSS: Main: 290996224 05:02:17 INFO - PID 2920 | 05:02:20 INFO - PID 2920 | Cycle 1(1): loaded http://localhost:61241/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:61241/tests/kraken/driver.html?testName=audio-fft) 05:02:20 INFO - PID 2920 | RSS: Main: 381308928 05:02:20 INFO - PID 2920 | 05:02:22 INFO - PID 2920 | Cycle 1(1): loaded http://localhost:61241/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:61241/tests/kraken/driver.html?testName=audio-oscillator) 05:02:23 INFO - PID 2920 | RSS: Main: 286326784 05:02:23 INFO - PID 2920 | 05:02:25 INFO - PID 2920 | Cycle 1(1): loaded http://localhost:61241/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:61241/tests/kraken/driver.html?testName=imaging-gaussian-blur) 05:02:26 INFO - PID 2920 | RSS: Main: 288702464 05:02:26 INFO - PID 2920 | 05:02:28 INFO - PID 2920 | Cycle 1(1): loaded http://localhost:61241/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:61241/tests/kraken/driver.html?testName=imaging-darkroom) 05:02:29 INFO - PID 2920 | RSS: Main: 353218560 05:02:29 INFO - PID 2920 | 05:02:32 INFO - PID 2920 | Cycle 1(1): loaded http://localhost:61241/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:61241/tests/kraken/driver.html?testName=imaging-desaturate) 05:02:33 INFO - PID 2920 | RSS: Main: 369950720 05:02:33 INFO - PID 2920 | 05:02:36 INFO - PID 2920 | Cycle 1(1): loaded http://localhost:61241/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:61241/tests/kraken/driver.html?testName=json-parse-financial) 05:02:36 INFO - PID 2920 | RSS: Main: 378351616 05:02:36 INFO - PID 2920 | 05:02:38 INFO - PID 2920 | Cycle 1(1): loaded http://localhost:61241/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:61241/tests/kraken/driver.html?testName=json-stringify-tinderbox) 05:02:38 INFO - PID 2920 | RSS: Main: 327532544 05:02:38 INFO - PID 2920 | 05:02:40 INFO - PID 2920 | Cycle 1(1): loaded http://localhost:61241/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:61241/tests/kraken/driver.html?testName=stanford-crypto-aes) 05:02:41 INFO - PID 2920 | RSS: Main: 330452992 05:02:41 INFO - PID 2920 | 05:02:43 INFO - PID 2920 | Cycle 1(1): loaded http://localhost:61241/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:61241/tests/kraken/driver.html?testName=stanford-crypto-ccm) 05:02:44 INFO - PID 2920 | RSS: Main: 314417152 05:02:44 INFO - PID 2920 | 05:02:46 INFO - PID 2920 | Cycle 1(1): loaded http://localhost:61241/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:61241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 05:02:47 INFO - PID 2920 | RSS: Main: 351531008 05:02:47 INFO - PID 2920 | 05:02:50 INFO - PID 2920 | Cycle 1(1): loaded http://localhost:61241/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:61241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 05:02:51 INFO - PID 2920 | RSS: Main: 343674880 05:02:51 INFO - PID 2920 | 05:02:53 INFO - PID 2920 | Cycle 1(1): loaded http://localhost:61241/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:61241/tests/kraken/driver.html?testName=ai-astar) 05:02:53 INFO - PID 2920 | RSS: Main: 387465216 05:02:53 INFO - PID 2920 | 05:02:53 INFO - PID 2920 | __start_tp_report 05:02:53 INFO - PID 2920 | _x_x_mozilla_page_load 05:02:53 INFO - PID 2920 | _x_x_mozilla_page_load_details 05:02:53 INFO - PID 2920 | |i|pagename|runs| 05:02:53 INFO - PID 2920 | |0;ai-astar;111;110;110;110;111;113;109;111;112;112 05:02:53 INFO - PID 2920 | |1;audio-beat-detection;138;115;109;150;111;109;109;107;137;107 05:02:53 INFO - PID 2920 | |2;audio-dft;187;186;186;186;187;189;185;188;188;184 05:02:53 INFO - PID 2920 | |3;audio-fft;84;57;58;92;59;58;58;58;80;59 05:02:53 INFO - PID 2920 | |4;audio-oscillator;94;70;85;69;69;67;88;69;68;90 05:02:53 INFO - PID 2920 | |5;imaging-gaussian-blur;90;89;89;89;89;89;89;89;89;89 05:02:53 INFO - PID 2920 | |6;imaging-darkroom;95;95;96;102;151;122;96;96;95;95 05:02:53 INFO - PID 2920 | |7;imaging-desaturate;86;84;84;87;85;87;85;84;84;86 05:02:53 INFO - PID 2920 | |8;json-parse-financial;52;50;49;48;50;48;49;50;48;50 05:02:53 INFO - PID 2920 | |9;json-stringify-tinderbox;55;63;71;57;58;63;59;60;60;61 05:02:53 INFO - PID 2920 | |10;stanford-crypto-aes;83;83;85;81;82;82;82;83;82;82 05:02:53 INFO - PID 2920 | |11;stanford-crypto-ccm;140;135;137;133;128;152;150;131;226;154 05:02:53 INFO - PID 2920 | |12;stanford-crypto-pbkdf2;185;183;187;186;187;183;184;186;189;180 05:02:53 INFO - PID 2920 | |13;stanford-crypto-sha256-iterative;68;69;68;67;67;68;69;68;67;68 05:02:53 INFO - PID 2920 | __end_tp_report 05:02:53 INFO - PID 2920 | __start_cc_report 05:02:53 INFO - PID 2920 | _x_x_mozilla_cycle_collect,2153 05:02:53 INFO - PID 2920 | __end_cc_report 05:02:53 INFO - PID 2920 | __startTimestamp1494072173374__endTimestamp 05:02:53 INFO - PID 2920 | 05:02:53 INFO - PID 2920 | ------- Summary: start ------- 05:02:53 INFO - PID 2920 | Number of tests: 14 05:02:53 INFO - PID 2920 | 05:02:53 INFO - PID 2920 | [#0] ai-astar Cycles:10 Average:110.90 Median:111.00 stddev:1.20 (1.1%) stddev-sans-first:1.27 05:02:53 INFO - PID 2920 | Values: 111.0 110.0 110.0 110.0 111.0 113.0 109.0 111.0 112.0 112.0 05:02:53 INFO - PID 2920 | 05:02:53 INFO - PID 2920 | [#1] audio-beat-detection Cycles:10 Average:119.20 Median:113.00 stddev:16.03 (14.2%) stddev-sans-first:15.50 05:02:53 INFO - PID 2920 | Values: 138.0 115.0 109.0 150.0 111.0 109.0 109.0 107.0 137.0 107.0 05:02:53 INFO - PID 2920 | 05:02:53 INFO - PID 2920 | [#2] audio-dft Cycles:10 Average:186.60 Median:187.00 stddev:1.51 (0.8%) stddev-sans-first:1.59 05:02:53 INFO - PID 2920 | Values: 187.0 186.0 186.0 186.0 187.0 189.0 185.0 188.0 188.0 184.0 05:02:53 INFO - PID 2920 | 05:02:53 INFO - PID 2920 | [#3] audio-fft Cycles:10 Average:66.30 Median:59.00 stddev:13.46 (22.8%) stddev-sans-first:12.66 05:02:53 INFO - PID 2920 | Values: 84.0 57.0 58.0 92.0 59.0 58.0 58.0 58.0 80.0 59.0 05:02:53 INFO - PID 2920 | 05:02:53 INFO - PID 2920 | [#4] audio-oscillator Cycles:10 Average:76.90 Median:77.50 stddev:10.88 (14.0%) stddev-sans-first:9.62 05:02:53 INFO - PID 2920 | Values: 94.0 70.0 85.0 69.0 69.0 67.0 88.0 69.0 68.0 90.0 05:02:53 INFO - PID 2920 | 05:02:53 INFO - PID 2920 | [#5] imaging-gaussian-blur Cycles:10 Average:89.10 Median:89.00 stddev:0.32 (0.4%) stddev-sans-first:0.00 05:02:53 INFO - PID 2920 | Values: 90.0 89.0 89.0 89.0 89.0 89.0 89.0 89.0 89.0 89.0 05:02:53 INFO - PID 2920 | 05:02:53 INFO - PID 2920 | [#6] imaging-darkroom Cycles:10 Average:104.30 Median:95.00 stddev:18.42 (19.4%) stddev-sans-first:19.22 05:02:53 INFO - PID 2920 | Values: 95.0 95.0 96.0 102.0 151.0 122.0 96.0 96.0 95.0 95.0 05:02:53 INFO - PID 2920 | 05:02:53 INFO - PID 2920 | [#7] imaging-desaturate Cycles:10 Average:85.20 Median:85.50 stddev:1.23 (1.4%) stddev-sans-first:1.27 05:02:53 INFO - PID 2920 | Values: 86.0 84.0 84.0 87.0 85.0 87.0 85.0 84.0 84.0 86.0 05:02:53 INFO - PID 2920 | 05:02:53 INFO - PID 2920 | [#8] json-parse-financial Cycles:10 Average:49.40 Median:50.00 stddev:1.26 (2.5%) stddev-sans-first:0.93 05:02:53 INFO - PID 2920 | Values: 52.0 50.0 49.0 48.0 50.0 48.0 49.0 50.0 48.0 50.0 05:02:53 INFO - PID 2920 | 05:02:53 INFO - PID 2920 | [#9] json-stringify-tinderbox Cycles:10 Average:60.70 Median:60.50 stddev:4.40 (7.3%) stddev-sans-first:4.15 05:02:53 INFO - PID 2920 | Values: 55.0 63.0 71.0 57.0 58.0 63.0 59.0 60.0 60.0 61.0 05:02:53 INFO - PID 2920 | 05:02:53 INFO - PID 2920 | [#10] stanford-crypto-aes Cycles:10 Average:82.50 Median:82.50 stddev:1.08 (1.3%) stddev-sans-first:1.13 05:02:53 INFO - PID 2920 | Values: 83.0 83.0 85.0 81.0 82.0 82.0 82.0 83.0 82.0 82.0 05:02:53 INFO - PID 2920 | 05:02:53 INFO - PID 2920 | [#11] stanford-crypto-ccm Cycles:10 Average:148.60 Median:145.00 stddev:28.68 (19.8%) stddev-sans-first:30.25 05:02:53 INFO - PID 2920 | Values: 140.0 135.0 137.0 133.0 128.0 152.0 150.0 131.0 226.0 154.0 05:02:53 INFO - PID 2920 | 05:02:53 INFO - PID 2920 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.00 Median:186.00 stddev:2.58 (1.4%) stddev-sans-first:2.74 05:02:53 INFO - PID 2920 | Values: 185.0 183.0 187.0 186.0 187.0 183.0 184.0 186.0 189.0 180.0 05:02:53 INFO - PID 2920 | 05:02:53 INFO - PID 2920 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.90 Median:68.00 stddev:0.74 (1.1%) stddev-sans-first:0.78 05:02:53 INFO - PID 2920 | Values: 68.0 69.0 68.0 67.0 67.0 68.0 69.0 68.0 67.0 68.0 05:02:53 INFO - PID 2920 | -------- Summary: end -------- 05:02:53 INFO - PID 2920 | 05:02:54 INFO - TEST-INFO | 2920: exit 0 05:02:54 INFO - TEST-OK | kraken | took 60443ms 05:02:54 INFO - SUITE-END | took 1179s 05:02:54 INFO - Completed test suite (00:19:40) 05:02:54 INFO - javascript benchmark 05:02:54 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7706.732150102357, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [3377.054424761067, 3501.982490087549, 3509.05255580993, 3534.0, 3587.461880717892, 5492.1212605982955, 5773.700917293607, 6084.969575152129, 6245.375462453752, 6270.749170033199, 6101.2170667302, 6139.9828168395, 6181.134641150243, 6251.312355640887, 6273.9686301568545, 3815.67566756826, 5090.669106508084, 5184.611154163434, 5343.492368225013, 5357.919631205535, 5443.101888188444, 5473.397926228112, 5488.259085023531, 5495.422980587041, 5516.089845175541, 4354.716943398669, 5325.467453254643, 5333.040052790496, 5376.086065368897, 5407.270018547505, 5318.946810531923, 5344.251804747339, 5353.625246232766, 5354.196870469422, 5360.2227676987, 5237.8428647140645, 5295.099833028395, 5303.018941495836, 5317.521423071942, 5328.094223981932, 5004.524570165829, 5962.165296858443, 6030.9396906030815, 6032.396760323976, 6049.848753781191, 6397.0724244984685, 6404.135441715355, 6406.807795766134, 6417.7753778617525, 6425.45383642391, 6532.738690452376, 6581.605103693793, 6640.83397915056, 6666.866662666768, 6667.966660166668, 6347.52393570484, 6350.587211831216, 6350.9682451587905, 6351.396617321393, 6360.809175724736, 6558.147440832757, 6829.214640316427, 6851.2121106072445, 6855.828604284933, 6884.0, 6415.230172379251, 6439.678016099177, 6451.387118223761, 6465.418112369815, 6487.18910136233, 6570.5400621956005, 6572.309907459744, 6575.539712220098, 6589.604623722592, 6593.934060659428, 6447.6453795041725, 6451.0, 6457.096006559085, 6458.773942911976, 6470.838229044218, 6353.174087368612, 6392.328805475358, 6450.290468048511, 6469.935300646934, 6495.3179916109075, 5286.841394758163, 5289.629725919149, 5293.523582877482, 5314.176302673014, 5347.144456886879, 4666.043461090469, 4701.576858082721, 4702.318163866289, 4707.435107787088, 4749.691270067435, 6149.385061493815, 6243.531735119885, 6266.0, 6347.52393570484, 6415.294317625057, 6619.404253617197, 6655.900161497581, 6661.666916654148, 6671.799846004627, 6688.431483323972, 6338.207724034496, 6360.459360954371, 6375.0, 6378.776742814072, 6380.0, 5802.2114126472125, 5802.6808525531505, 5836.037053886146, 5840.123981402823, 5861.589688721749, 6593.571417857824, 6667.866642667216, 6802.659867006729, 6869.416099631588, 6899.551529150589, 6456.709448074942, 6495.253045899782, 6715.0, 6717.731290748316, 6717.932820671731, 5669.433056694297, 6715.899261510984, 6793.558418702769, 6905.723771049303, 6919.446444284345, 6504.4796416285635, 6504.869902601827, 6504.869902602016, 6530.934690653033, 6549.148610680581, 5394.622376433612, 6491.740330386731, 6646.9002964956535, 6664.200295964515, 6667.733290668319, 5229.607779416635, 6376.3623637635865, 6414.647194404352, 6424.550281480251, 6428.517861160338, 6442.452391546771, 6448.193975753031, 6466.838329041811, 6473.352664733489, 6476.967615161894, 6358.554901156875, 6360.586561873463, 6373.8725225496155, 6420.390062944013, 6422.486201103994, 6324.3991820776955, 6407.295197528361, 6424.229092508929, 6438.227412710505, 6503.317151699003, 6334.3665633436285, 6400.327965563549, 6412.1023056771155, 6422.967885160544, 6443.581167224115], "value": 6001.665846532742, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [791.8653828849095, 809.6558962440963, 1007.3250921882338, 1108.6618581332696, 1137.2096393006864, 33167.502487462676, 36531.08672283198, 36599.0, 36648.81675591625, 36725.878300344506, 38436.42345364822, 38743.612563874354, 38790.418143727795, 38813.61186388135, 38822.8058859706, 5973.940260597404, 8161.79595510114, 8291.709790157345, 8308.875366869472, 8309.459885107448, 6008.0, 8185.3042491388305, 8318.66725330989, 8344.457610255344, 8355.99728032637, 8373.916260837375, 8419.684586738635, 8425.07324194338, 8428.957855210716, 8487.151284871494, 5935.73289201987, 8155.877661835048, 8331.625076871525, 8397.286230670401, 8404.957975210145, 5492.313460817398, 5983.820485385445, 6041.758329666852, 6041.939580604182, 8144.5113293202, 36020.0, 36278.45582316241, 36284.63715362839, 36339.0, 36414.271714565824, 3533.593636731783, 3570.357335679577, 3574.874879379235, 3576.0, 3586.5158203642436, 29781.702182978326, 29802.70197298021, 29832.70167298321, 29849.552256716168, 29908.95318663858, 3072.8617212225504, 3146.496560550324, 3162.8892988745515, 3170.381775553768, 3183.729383002448, 274588.0, 280414.0, 280452.0, 281215.99999999796, 281318.0, 37821.432678509846, 38429.0, 47585.76207118942, 47778.522214777404, 47930.33114701631, 40035.79982100129, 48490.75754621275, 48874.75562622164, 48941.265881011816, 48984.0, 13087.541936032194, 13182.0, 13196.538121165713, 13197.604071877859, 13202.141860779018, 10713.196510261605, 10725.731856703645, 10736.033756961911, 10752.516136773864, 10767.138628909668, 11601.477933493014, 11619.0, 11635.767284654428, 11738.882611173949, 11752.177347585586, 5275.129603615437, 5367.463253674601, 5374.11327131019, 5379.300690910235, 5392.762003768471, 947.8530827721714, 972.9200587348038, 1025.9025392587691, 1060.4644654449453, 1067.567635107767, 22315.10739570399, 23059.61642301467, 24099.75900240975, 24118.0, 24503.877480612482, 1105.4693747001484, 1113.1762495753085, 1138.692553010699, 1149.7010777197988, 1172.8447479232948, 11858.584949526898, 12129.150959432754, 12221.755564888652, 12248.632541023606, 12311.876881231252, 263528.0, 303718.0, 308372.0, 308468.0, 310085.0, 49516.75241623769, 49518.0, 49552.752236238586, 49621.0, 49704.0, 1472.5287907869379, 1496.9999999999782, 1543.1744016951102, 1545.8840586956023, 1571.088768514259, 17461.650766984334, 22666.0, 22826.858657067412, 23340.2997910063, 28986.710132898403, 40058.59941400549, 48612.02775944532, 48826.26760598665, 48851.0, 48934.75532622314, 182722.0, 182889.0, 183191.0, 183446.0827695853, 183545.0, 27683.169504914884, 28041.859790700917, 31953.68046319507, 31986.360272793947, 32104.197395065312, 33371.66628333783, 42484.08821602973, 43061.0, 43094.35358469563, 43188.784056079516, 22190.55618887581, 23312.417189570395, 29485.705142948296, 29607.407851843273, 30232.395352092393, 29408.41183176367, 29826.10521684353, 29951.101466956025, 29979.950701725335, 30337.0, 34434.96695099151, 35375.58497660065, 35433.46849797307, 35648.10879728028, 35933.820330898176, 24849.378765531008, 29181.70818291875, 30188.69811301859, 30297.93957211487, 30546.84726576353, 22539.43651408728, 23278.0, 23625.881870590536, 23654.763452365944, 23799.52400952006], "value": 16563.083002658113, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [410.49509103802325, 421.6289665094718, 427.08816676395884, 435.790820406205, 451.1608408360449, 19061.61876762464, 20850.791492085074, 21317.0, 21584.028718707657, 21603.45991350215, 21620.35138945834, 21979.120835166574, 22062.558748825013, 22234.88882555585, 22266.55466890661, 5978.0, 6248.781292654758, 6251.843703907393, 6271.655058971754, 6274.529410294223, 5878.206442130322, 6074.240719910012, 6117.632942023471, 6196.442320191182, 6200.875982480347, 6090.177825993501, 6155.353687862777, 6163.352847950968, 6165.784197553086, 6179.3202747697715, 5939.1388248703915, 6153.784617538365, 6153.876922461548, 6156.076588511714, 6156.6921653917125, 5192.428832828386, 5313.840584782462, 5449.0, 5457.890842183134, 5458.426865179139, 26639.733602664113, 27064.729352706418, 27595.0, 27915.720842791514, 28453.430931381463, 2124.968125478119, 2210.8784016879067, 2211.3255457085584, 2213.8007579317778, 2214.169686367612, 17747.911260443743, 17848.01835899025, 17911.552211194696, 18313.992730399823, 18575.44273671792, 2127.7872212778752, 2127.9680804787786, 2185.595664802017, 2187.726534183227, 2187.9234226801987, 143273.0, 145042.27478862644, 146810.99999999892, 146862.0, 147285.0, 11769.646910592695, 12207.511699531919, 12264.81602775959, 12270.202436841577, 12273.509059637692, 15719.842801572067, 15765.290561924512, 16110.275037623334, 16381.508554743377, 16391.754123688155, 8724.214820666171, 8842.071582483746, 8943.284537237136, 8989.775255618531, 9051.683191088281, 8405.915940840514, 8422.368322375847, 8433.325333973391, 8582.0, 8610.61252243638, 7579.962100189574, 7690.730824421118, 7721.498102623312, 7722.652480638385, 7756.418268629763, 1857.9721304180448, 2169.5680850638505, 2190.89045547722, 2193.5283913958574, 2339.9766002340098, 952.6713283917038, 956.5221732423422, 956.7608097975506, 983.439439519467, 1006.1196453103535, 20157.0, 20514.38456846297, 20580.897095514727, 20733.905771226644, 20820.37538873836, 980.4754456365953, 990.8753564704112, 1007.450939238117, 1016.4511163971521, 1017.1405162637559, 10326.657534520464, 10527.894721052844, 10537.683869483928, 10569.048785609179, 10626.89373106259, 530269.0, 538222.0, 544561.0, 551473.0, 551677.0, 89124.0, 118521.0, 126161.0, 126457.0, 128288.35855820662, 1132.3602164776876, 1139.8658334956606, 1193.4754043293144, 1252.8371311729418, 1254.1283807753707, 20533.0, 20727.8963605181, 20937.790622093584, 21006.159753610296, 21103.8944805275, 52994.73502632462, 54055.72972135271, 55114.0, 55310.72344638251, 55722.72138639281, 43301.783491082344, 74115.88826167503, 77121.84317235133, 77339.61330193539, 78630.0, 8177.000503522181, 8320.625571849403, 8325.750227493185, 8816.86774698393, 8819.029906710128, 10538.736531586772, 12951.417186226454, 13255.867441325463, 13661.0, 13721.313934303445, 11047.779044419227, 11134.0, 11398.94300528492, 11434.913683200082, 11601.76796464049, 8624.396292259482, 10284.742881428025, 10762.031417172491, 10896.836547451952, 11112.610653750684, 9724.0, 10203.897961020295, 11867.991220746333, 12082.879171208175, 12178.817317740064, 8446.788830279047, 8534.78663033429, 8674.826503470022, 8696.652133914826, 8922.955385223033, 11654.88345116538, 11835.81641835844, 11900.63142738596, 11924.642260732191, 11926.582569610022], "value": 10247.29195990438, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1191.3507138609457, 1387.535175716135, 1411.1674112273756, 1426.465075596652, 1453.360521370597, 9640.0, 10050.94465081166, 10944.890551094486, 11448.508204997472, 11596.884031159685, 11260.324380537173, 11359.659210223686, 11369.09047276218, 11390.886091139108, 11394.031507321888, 2105.3683894831565, 2446.865422401772, 2487.0797804812246, 2492.015653816741, 2506.3608779761134, 2004.4587961250454, 2059.8455115866295, 2152.1499007891875, 2472.468419289852, 2490.7260201377835, 2450.13020377766, 2479.466914613358, 2484.1181380609896, 2484.3664865459373, 2484.7391023942496, 2146.720926279589, 2152.9784702152933, 2319.85167342165, 2416.0, 2461.0893969231497, 2431.6474111253947, 2440.023990403835, 2446.3028037009544, 2451.521953219123, 2451.9264422067367, 11184.496697648545, 11495.885041149566, 11496.0, 11525.42372881361, 11557.826632600518, 5517.5585953123655, 6322.87354252917, 6545.37818907203, 6564.737410503574, 6583.506237032242, 3952.4664170336923, 4143.047099167178, 4261.722988005769, 4279.079997800488, 4284.464441944757, 1232.1498166265249, 1261.1550261324935, 1301.6745813546613, 1302.9804552931714, 1308.613958882132, 16407.261673224733, 16412.261448234978, 16439.506814795575, 16455.09496977666, 16455.177241137895, 5450.5639548836, 5641.351244606841, 5853.443922827325, 5869.882602347929, 5928.288605367384, 13549.864501355058, 13552.254625995665, 13561.254131022692, 13575.932120339336, 13589.252591107386, 6538.542302038907, 6676.965070414093, 6683.365080317362, 6693.765718199937, 6700.731970721214, 5974.551908606872, 6169.753209871645, 6191.9690401548605, 6192.380761923771, 6217.098520714561, 3562.340966921128, 3851.691864650821, 3936.3505021671103, 3936.881893543198, 4329.220740266782, 1243.198137201518, 1252.3550371558472, 1272.783626783449, 1272.821804947308, 1284.6338793443824, 789.9249571290718, 801.8373358630009, 814.9470284431493, 820.2658620534708, 849.2229609906866, 6434.7104380303, 6436.581622194542, 6607.306232845578, 6711.328867113347, 6852.828679282959, 707.6072779607265, 741.2513361504919, 890.9331800115017, 892.4199270474244, 906.805036917066, 3164.0666003529013, 3755.0424641716736, 3763.6074652378793, 3941.5270167580074, 4166.395872598457, 14569.125852448888, 14888.553343399715, 15050.849491504945, 15051.623709407353, 15174.089554626758, 12105.334206618545, 14925.88055895812, 14944.0, 14958.925205374122, 14974.326155323037, 8111.553864537507, 8610.61252243638, 8637.784055398666, 8648.43785153963, 8667.566621668891, 6735.4611631070375, 6769.661516924232, 6804.319568043156, 6997.4052205561065, 7023.157221133497, 13144.671383215496, 13439.193648381128, 13543.119697219649, 13590.79613805774, 13664.863351366359, 13190.802137967747, 13438.328083595976, 13696.3836627354, 13781.931090344484, 13791.172529648253, 9267.258619310574, 9419.293552983416, 9434.198093162158, 9435.952820235854, 9440.48077355752, 8534.74395768128, 10616.734581635521, 10696.732581685521, 10731.195160362848, 10743.623973160902, 8930.687425940061, 9027.0, 9058.184763371328, 9117.316201284797, 9257.120573545502, 8785.428947118417, 8899.15458031486, 8980.685676001309, 8992.640294388151, 9150.816983660423, 6430.903536447051, 7678.577678227751, 8079.313258372869, 8089.9191008089165, 8109.107998120084, 5971.910421343597, 6086.452219300284, 6099.329073801967, 6137.570370074052, 6170.5372097092, 6034.849128771816, 6096.756129754937, 6149.41580549847, 6197.938020619917, 6233.532485063548], "value": 5289.901298139862, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [375.56059410489723, 377.83752986215916, 383.38849534991687, 387.0343492985003, 391.49301654357606, 5149.716765577892, 5720.199172115902, 5884.205632239647, 5895.174675545421, 5918.585699001072, 5165.915157816863, 5623.0, 5629.831105066844, 5807.0, 5857.147137848717, 4458.0, 4459.076013108476, 4463.9553604463945, 4467.374567560544, 4469.971906461516, 3688.409854423293, 4456.9777151114195, 4496.190685676577, 4505.098980203956, 4508.233600287943, 3756.5492140943124, 4252.447181866369, 4336.176126535964, 4458.910821783563, 4480.97759511202, 3834.789086600236, 4383.517813040563, 4393.0, 4411.073674528353, 4424.672598220521, 3050.1154665147083, 3432.622411534729, 3903.707221958336, 3917.784521851297, 3921.3529767588598, 5359.356877174764, 5368.32895888014, 5519.0, 5658.547316214693, 5804.419558044204, 4426.313921342197, 4461.620762235214, 5291.576673866081, 5337.919931201035, 5390.460953904618, 5477.946319723415, 5717.456841600041, 6221.3156552779155, 6231.532635052389, 6257.124002639634, 3989.0426297688637, 4213.883320919958, 4425.269830477967, 4439.64482841372, 4480.955190448119, 6390.265119511269, 6518.120053792724, 6536.673166341711, 6657.533972621918, 6687.933120668828, 4260.786960651955, 4329.545397733255, 4574.611158051536, 4576.954230457719, 4581.312803079565, 3568.57177138745, 4530.474488783032, 4549.862534366408, 4598.747068911175, 4807.687500312539, 5126.6923984561045, 5373.11343628297, 5401.189821526802, 5417.702026388586, 5438.7280635968045, 5064.848054558369, 6341.397567231198, 6364.872702545923, 6371.840703982438, 6393.520485963571, 1547.636305468214, 1621.570283874774, 1645.3007471824667, 1647.0, 1649.2743192995044, 1018.4602160854758, 1115.9553617855356, 1141.9885801141882, 1143.1940481960198, 1144.296257801446, 5966.492848107872, 6012.879742405127, 6022.819315420545, 6030.396960303934, 6063.878722425527, 5441.918371224435, 6144.938550614526, 6497.967510162419, 6517.837054073686, 6545.280019197884, 5811.88376232473, 5838.824835254949, 5955.196048533479, 5998.400159984054, 6081.361457046946, 3121.4693502104697, 3184.251700850298, 3329.716974057232, 3371.275175837207, 3422.4524076147695, 5146.459621739664, 6190.783322583688, 6600.646867392173, 6769.0, 6803.081583986197, 5910.6707682473425, 6324.462420694293, 6737.3599508046655, 6776.898346524707, 6836.760713375008, 5089.974550127374, 5952.7321270542925, 6253.96873015632, 6711.136459444122, 6820.612785525027, 5652.378238393691, 5720.599558030898, 6064.636121832704, 6391.744330226739, 6412.487001039813, 5340.946590534045, 5789.594728368974, 6094.0, 6434.195725534309, 6495.577787443801, 6394.0, 6477.676116194266, 6757.797266082025, 6785.59286442815, 6794.490413219127, 4137.296659567821, 4445.222086134849, 4693.6949098308505, 4704.88280273885, 4730.432348118248, 6317.241930968313, 6579.835504112435, 6588.637624930675, 6611.404973552403, 6616.5368424211765, 4966.751662416792, 6249.531435083208, 6284.748610055546, 6295.622262664255, 6351.9047214290895, 5241.895162096813, 5524.4199359068325, 6133.601315914451, 6344.206974128234, 6345.857745605836, 5292.52367286946, 5700.800471983461, 6035.9094613579955, 6103.298120716175, 6203.534734894991, 5603.915941260966, 6311.368863113836, 6324.406993132793, 6363.96818015907, 6373.171487706569, 5047.4700156484505, 5671.838626849547, 6142.055645205653, 6159.753609855556, 6164.969175154096], "value": 4623.435205615306, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [713.4684659928354, 821.2567626298202, 846.8052347959965, 853.398354160317, 859.1923591823685, 16054.197290135506, 16380.590485237844, 16403.4258800942, 16447.917760411197, 16494.340226390945, 15216.0, 16756.748648770277, 17649.55876103098, 17867.642647147048, 17927.924324540505, 980.901909809017, 987.5901500877127, 988.3229987458614, 989.0208693393524, 990.2424645146468, 1030.0008991278448, 1030.6701855406272, 1030.7732298894232, 1031.767852233249, 1034.4258936290355, 1073.2272763610188, 1074.1514203779004, 1074.6829685242833, 1075.1130317488064, 1079.4063265204145, 1048.130052056791, 1059.3061544688203, 1066.3282132256668, 1071.4107241017448, 1075.5267682219799, 778.9182135875708, 782.1865260129458, 782.2529484342439, 782.9021372328459, 784.4979213303491, 15521.301541430663, 15736.68526629461, 17126.400575979904, 17307.653846923116, 17325.653486930318, 16500.17499125039, 16546.172691365384, 16912.661746764996, 17191.82808171927, 17462.825371746247, 13956.371963261678, 14147.575572732834, 14193.361298741582, 14335.139891606537, 14408.06347587414, 3523.594786599548, 3547.0, 3548.5741710994844, 3549.2901419715904, 3550.343186510504, 90718.63922041241, 137056.0, 137478.0, 138220.0, 140084.0, 10602.310849794738, 11163.665090047312, 11281.605143819927, 11611.593594224161, 11968.760624787456, 24960.625590616157, 25722.48555028889, 26060.348491287492, 26096.478070438865, 26448.603270950953, 7518.173000969889, 7686.192949740197, 8063.354931605458, 8107.797305067421, 8111.432199746079, 3913.4325522799036, 3989.6608788253325, 3990.2817492851564, 3992.4210989406956, 3996.300647386696, 4165.8958526037095, 4208.263553878059, 4256.765877876746, 4257.254980378421, 4319.827206911688, 920.2591913509689, 925.6251218256617, 943.8725772020827, 948.3551185193996, 948.6300342866288, 639.763287583597, 649.3863299182227, 659.7492952677952, 660.6663634864362, 680.625655889259, 10262.715154652422, 10801.83797243042, 12009.159358844798, 12090.879091209152, 12132.029437644967, 647.0552992630812, 655.0599889159072, 656.7274581048907, 658.2463079773728, 682.5699809120223, 5411.702356370359, 5546.58400619947, 5568.470995255444, 5572.136318870582, 5676.403977582377, 82126.58936705279, 94990.57514137293, 100021.0, 109316.0, 109334.53853756306, 87098.56450717706, 90777.54611227034, 93753.5312323434, 94573.0, 96084.02865613053, 58249.417505825244, 81868.0, 84993.15006849852, 85493.14506854852, 85613.28773424496, 10504.42225677595, 10970.286931349438, 11121.94439027832, 11258.930401611833, 11491.253068550517, 38792.61207388003, 39157.41263881101, 39298.0, 41257.38113928233, 41619.843634400386, 69259.65370173116, 71910.64044679744, 72596.63701681458, 74921.25078749143, 76185.17561469947, 15601.375944962529, 16381.689464842546, 16510.257038433057, 16724.0, 16962.83037169662, 17075.573110672332, 17157.57106072358, 17693.292268309637, 17975.191116400056, 18822.905885470485, 16417.343306268092, 16690.916545417196, 17303.30786768515, 17433.912830435765, 17550.912245438692, 16615.3353865844, 17191.914040429718, 17351.13244337753, 17421.651566968336, 17505.82494175093, 16167.595810104842, 16649.667006659558, 16766.993980361218, 16847.326106955585, 16977.830221697626, 10920.453977301262, 11678.88321116778, 11981.64055078349, 12113.636590902288, 12381.876181238433, 11664.533418663159, 12833.614991550268, 13002.739945201232, 13040.804387933998, 13079.542216022393], "value": 8409.23770858504, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1432.6000000000001, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 110.0, 110.0, 110.0, 111.0, 113.0, 109.0, 111.0, 112.0, 112.0], "value": 110.9, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 115.0, 109.0, 150.0, 111.0, 109.0, 109.0, 107.0, 137.0, 107.0], "value": 119.2, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [187.0, 186.0, 186.0, 186.0, 187.0, 189.0, 185.0, 188.0, 188.0, 184.0], "value": 186.6, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [84.0, 57.0, 58.0, 92.0, 59.0, 58.0, 58.0, 58.0, 80.0, 59.0], "value": 66.3, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [94.0, 70.0, 85.0, 69.0, 69.0, 67.0, 88.0, 69.0, 68.0, 90.0], "value": 76.9, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 89.0, 89.0, 89.0, 89.0, 89.0, 89.0, 89.0, 89.0, 89.0], "value": 89.1, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [95.0, 95.0, 96.0, 102.0, 151.0, 122.0, 96.0, 96.0, 95.0, 95.0], "value": 104.3, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [86.0, 84.0, 84.0, 87.0, 85.0, 87.0, 85.0, 84.0, 84.0, 86.0], "value": 85.2, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [52.0, 50.0, 49.0, 48.0, 50.0, 48.0, 49.0, 50.0, 48.0, 50.0], "value": 49.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [55.0, 63.0, 71.0, 57.0, 58.0, 63.0, 59.0, 60.0, 60.0, 61.0], "value": 60.7, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 83.0, 85.0, 81.0, 82.0, 82.0, 82.0, 83.0, 82.0, 82.0], "value": 82.5, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [140.0, 135.0, 137.0, 133.0, 128.0, 152.0, 150.0, 131.0, 226.0, 154.0], "value": 148.6, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [185.0, 183.0, 187.0, 186.0, 187.0, 183.0, 184.0, 186.0, 189.0, 180.0], "value": 185.0, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [68.0, 69.0, 68.0, 67.0, 67.0, 68.0, 69.0, 68.0, 67.0, 68.0], "value": 67.9, "unit": "score"}]}]} 05:02:54 INFO - Return code: 0 05:02:54 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 05:02:54 INFO - # TBPL SUCCESS # 05:02:54 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 05:02:54 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 05:02:54 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 05:02:54 INFO - 2017-05-06 05:02:54.695 screenresolution[2925:54160] starting screenresolution argv=screenresolution get 05:02:54 INFO - 2017-05-06 05:02:54.698 screenresolution[2925:54160] Display 0: 1600x1200x32@60 05:02:54 INFO - 2017-05-06 05:02:54.704 screenresolution[2926:54162] starting screenresolution argv=screenresolution list 05:02:54 INFO - Available Modes on Display 0 05:02:54 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 05:02:54 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 05:02:54 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 05:02:54 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 05:02:54 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 05:02:54 INFO - Intel Iris: 05:02:54 INFO - Chipset Model: Intel Iris 05:02:54 INFO - Type: GPU 05:02:54 INFO - Bus: Built-In 05:02:54 INFO - VRAM (Dynamic, Max): 1536 MB 05:02:54 INFO - Vendor: Intel (0x8086) 05:02:54 INFO - Device ID: 0x0a2e 05:02:54 INFO - Revision ID: 0x0009 05:02:54 INFO - Displays: 05:02:54 INFO - Display: 05:02:54 INFO - Resolution: 1600 x 1200 @ 60 Hz 05:02:54 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 05:02:54 INFO - Display Serial Number: 1600x1200 60 05:02:54 INFO - Main Display: Yes 05:02:54 INFO - Mirror: Off 05:02:54 INFO - Online: Yes 05:02:54 INFO - Rotation: Supported 05:02:54 INFO - Return code: 0 05:02:54 INFO - Running post-action listener: _resource_record_post_action 05:02:54 INFO - [mozharness: 2017-05-06 12:02:54.952748Z] Finished run-tests step (success) 05:02:54 INFO - Running post-run listener: _resource_record_post_run 05:02:55 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 483840; Write bytes: 505140224; Read time: 8; Write time: 1604 05:02:55 INFO - TinderboxPrint: CPU usage
53.4% 05:02:55 INFO - TinderboxPrint: I/O read bytes / time
483,840 / 8 05:02:55 INFO - TinderboxPrint: I/O write bytes / time
505,140,224 / 1,604 05:02:55 INFO - TinderboxPrint: CPU idle
2,235.7 (46.6%) 05:02:55 INFO - TinderboxPrint: CPU system
960.8 (20.0%) 05:02:55 INFO - TinderboxPrint: CPU user
1,605.3 (33.4%) 05:02:55 INFO - TinderboxPrint: Swap in / out
208,191,488 / 0 05:02:55 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 207636992; Write bytes: 205494272; Read time: 16071; Write time: 449 05:02:55 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 475136; Write bytes: 292445184; Read time: 3; Write time: 1109 05:02:55 INFO - Running post-run listener: _upload_blobber_files 05:02:55 INFO - Blob upload gear active. 05:02:55 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 05:02:55 INFO - Files from /builds/slave/test/build/blobber_upload_dir are to be uploaded with branch at the following location(s): https://blobupload.elasticbeanstalk.com 05:02:55 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/venv/bin/blobberc.py', '-u', 'https://blobupload.elasticbeanstalk.com', '-a', '/builds/slave/test/oauth.txt', '-b', 'Firefox', '-d', '/builds/slave/test/build/blobber_upload_dir', '--output-manifest', '/builds/slave/test/build/uploaded_files.json'] 05:02:55 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/venv/bin/blobberc.py -u https://blobupload.elasticbeanstalk.com -a /builds/slave/test/oauth.txt -b Firefox -d /builds/slave/test/build/blobber_upload_dir --output-manifest /builds/slave/test/build/uploaded_files.json 05:02:55 INFO - (blobuploader) - INFO - Open directory for files ... 05:02:55 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 05:02:55 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:55 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:56 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 05:02:56 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:56 INFO - (blobuploader) - INFO - Done attempting. 05:02:56 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 05:02:56 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:56 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:57 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 05:02:57 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:57 INFO - (blobuploader) - INFO - Done attempting. 05:02:57 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 05:02:57 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:57 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:02:58 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 05:02:58 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:02:58 INFO - (blobuploader) - INFO - Done attempting. 05:02:58 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 05:02:58 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 05:02:58 INFO - (blobuploader) - INFO - Uploading, attempt #1. 05:03:00 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 05:03:00 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 05:03:00 INFO - (blobuploader) - INFO - Done attempting. 05:03:00 INFO - (blobuploader) - INFO - Iteration through files over. 05:03:00 INFO - Return code: 0 05:03:00 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 05:03:00 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 05:03:00 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f62a455252af103d14930e6f14753b2c237e01081fe57d84ac032eb171439ac52fcdccc22704c09f2a9b874aa91695063e00c1a753ec475dc5720559f4cd7a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43041629101e03c3ca0062eefb839c297126803f381494d05c8ba3f3b456e23dc800f16ec27fa94cbf37d8562d3216f291c5b9f0eecd364b48c107826cbd0682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1acdd6943b4de7e7339c92cde7302999df1adffd02683731359ea17f171cd1d4720439ee78d5dba7ce7fd59eebec18875c4a83f63e7e8244be90f1a755e78a6b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa70b34ad4fd478541d921621f46229fb8c3243f5e1a27015a60a64dbea9eed31f629fbaed397d1c1d957d648412f21c74f84b792a6bd71fa85973577486e4f1"} 05:03:00 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 05:03:00 INFO - Writing to file /builds/slave/test/properties/blobber_files 05:03:00 INFO - Contents: 05:03:00 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f62a455252af103d14930e6f14753b2c237e01081fe57d84ac032eb171439ac52fcdccc22704c09f2a9b874aa91695063e00c1a753ec475dc5720559f4cd7a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43041629101e03c3ca0062eefb839c297126803f381494d05c8ba3f3b456e23dc800f16ec27fa94cbf37d8562d3216f291c5b9f0eecd364b48c107826cbd0682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1acdd6943b4de7e7339c92cde7302999df1adffd02683731359ea17f171cd1d4720439ee78d5dba7ce7fd59eebec18875c4a83f63e7e8244be90f1a755e78a6b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa70b34ad4fd478541d921621f46229fb8c3243f5e1a27015a60a64dbea9eed31f629fbaed397d1c1d957d648412f21c74f84b792a6bd71fa85973577486e4f1"} 05:03:00 INFO - Running post-run listener: copy_logs_to_upload_dir 05:03:00 INFO - Copying logs to upload dir... 05:03:00 INFO - mkdir: /builds/slave/test/build/upload/logs 05:03:00 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.411737 ========= master_lag: 0.09 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-05-06 05:03:00.836393) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-06 05:03:00.841544) ========= 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.rmjvULfCjw/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.iXtlQSgagG/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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/8f62a455252af103d14930e6f14753b2c237e01081fe57d84ac032eb171439ac52fcdccc22704c09f2a9b874aa91695063e00c1a753ec475dc5720559f4cd7a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43041629101e03c3ca0062eefb839c297126803f381494d05c8ba3f3b456e23dc800f16ec27fa94cbf37d8562d3216f291c5b9f0eecd364b48c107826cbd0682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1acdd6943b4de7e7339c92cde7302999df1adffd02683731359ea17f171cd1d4720439ee78d5dba7ce7fd59eebec18875c4a83f63e7e8244be90f1a755e78a6b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa70b34ad4fd478541d921621f46229fb8c3243f5e1a27015a60a64dbea9eed31f629fbaed397d1c1d957d648412f21c74f84b792a6bd71fa85973577486e4f1"} build_url:https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.011382 build_url: 'https://queue.taskcluster.net/v1/task/FDNhugVSRz2mumw2p_j1Aw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg' blobber_files: '{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/8f62a455252af103d14930e6f14753b2c237e01081fe57d84ac032eb171439ac52fcdccc22704c09f2a9b874aa91695063e00c1a753ec475dc5720559f4cd7a5", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43041629101e03c3ca0062eefb839c297126803f381494d05c8ba3f3b456e23dc800f16ec27fa94cbf37d8562d3216f291c5b9f0eecd364b48c107826cbd0682", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/1acdd6943b4de7e7339c92cde7302999df1adffd02683731359ea17f171cd1d4720439ee78d5dba7ce7fd59eebec18875c4a83f63e7e8244be90f1a755e78a6b", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/fa70b34ad4fd478541d921621f46229fb8c3243f5e1a27015a60a64dbea9eed31f629fbaed397d1c1d957d648412f21c74f84b792a6bd71fa85973577486e4f1"}' ========= master_lag: 0.02 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-06 05:03:00.877195) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-06 05:03:00.877512) ========= 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.rmjvULfCjw/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.iXtlQSgagG/Listeners TMPDIR=/var/folders/rl/_gz3yxcs4s1f_08bbj7xmf7w00000w/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.005250 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-06 05:03:00.926024) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-06 05:03:00.926348) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-06 05:03:00.926671) ========= ========= Total master_lag: 0.27 =========