builder: mozilla-central_yosemite_r7_test-dromaeojs slave: t-yosemite-r7-0177 starttime: 1493996206.39 results: success (0) buildid: 20170505061915 builduid: 2132191575764827a98b778f3c8898d3 revision: 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 ========= Started set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 07:56:46.392221) ========= master: http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/ ========= Finished set props: master (results: 0, elapsed: 0 secs) (at 2017-05-05 07:56:46.392661) ========= ========= Started downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 07:56:46.392930) ========= ========= Finished downloading to buildprops.json (results: 0, elapsed: 0 secs) (at 2017-05-05 07:56:46.419012) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:56:46.419293) ========= 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.N9XodRpkAm/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.oIhna2G1pN/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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-05 07:56:46-- 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% 15.2M=0.001s 2017-05-05 07:56:47 (15.2 MB/s) - 'archiver_client.py' saved [12179/12179] program finished with exit code 0 elapsedTime=0.137419 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:56:46.582310) ========= ========= Started 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:56:46.582688) ========= 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.N9XodRpkAm/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.oIhna2G1pN/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.027326 ========= master_lag: 0.03 ========= ========= Finished 'rm -rf ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 07:56:46.636107) ========= ========= Started 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 07:56:46.636852) ========= bash -c 'python archiver_client.py mozharness --repo mozilla-central --rev 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 --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 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 --destination scripts --debug'] environment: Apple_PubSub_Socket_Render=/private/tmp/com.apple.launchd.N9XodRpkAm/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.oIhna2G1pN/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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-05 07:56:47,247 truncating revision to first 12 chars 2017-05-05 07:56:47,247 Setting DEBUG logging. 2017-05-05 07:56:47,247 attempt 1/10 2017-05-05 07:56:47,247 Getting archive location from https://api.pub.build.mozilla.org/archiver/hgmo/mozilla-central/8872ad4d52b6?&preferred_region=us-west-2&suffix=tar.gz&subdir=testing/mozharness 2017-05-05 07:56:48,698 unpacking tar archive at: mozilla-central-8872ad4d52b6/testing/mozharness/ program finished with exit code 0 elapsedTime=1.727117 ========= master_lag: 0.03 ========= ========= Finished 'bash -c ...' (results: 0, elapsed: 1 secs) (at 2017-05-05 07:56:48.391279) ========= ========= Started set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 07:56:48.392002) ========= script_repo_revision: 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 ========= Finished set props: script_repo_revision (results: 0, elapsed: 0 secs) (at 2017-05-05 07:56:48.392571) ========= ========= Started downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 07:56:48.392844) ========= ========= Finished downloading to oauth.txt (results: 0, elapsed: 0 secs) (at 2017-05-05 07:56:48.413464) ========= ========= Started '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-05-05 07:56:48.413829) ========= /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.N9XodRpkAm/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.oIhna2G1pN/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:56:49 INFO - MultiFileLogger online at 20170505 07:56:49 in /builds/slave/test 07:56:49 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 07:56:49 INFO - Dumping config to /builds/slave/test/logs/localconfig.json. 07:56:49 INFO - {'append_to_log': False, 07:56:49 INFO - 'base_work_dir': '/builds/slave/test', 07:56:49 INFO - 'blob_upload_branch': 'Firefox', 07:56:49 INFO - 'blob_uploader_auth_file': '/builds/slave/test/oauth.txt', 07:56:49 INFO - 'branch': 'Firefox', 07:56:49 INFO - 'buildbot_json_path': 'buildprops.json', 07:56:49 INFO - 'config_files': ('talos/mac_config.py',), 07:56:49 INFO - 'default_actions': ('clobber', 07:56:49 INFO - 'read-buildbot-config', 07:56:49 INFO - 'download-and-extract', 07:56:49 INFO - 'populate-webroot', 07:56:49 INFO - 'create-virtualenv', 07:56:49 INFO - 'install', 07:56:49 INFO - 'run-tests'), 07:56:49 INFO - 'default_blob_upload_servers': ('https://blobupload.elasticbeanstalk.com',), 07:56:49 INFO - 'download_minidump_stackwalk': True, 07:56:49 INFO - 'download_symbols': 'ondemand', 07:56:49 INFO - 'exes': {'python': '/tools/buildbot/bin/python', 07:56:49 INFO - 'tooltool.py': '/tools/tooltool.py', 07:56:49 INFO - 'virtualenv': ('/tools/buildbot/bin/python', 07:56:49 INFO - '/tools/misc-python/virtualenv.py')}, 07:56:49 INFO - 'find_links': ('http://pypi.pvt.build.mozilla.org/pub', 07:56:49 INFO - 'http://pypi.pub.build.mozilla.org/pub'), 07:56:49 INFO - 'gecko_profile': False, 07:56:49 INFO - 'gecko_profile_interval': 0, 07:56:49 INFO - 'installer_path': 'installer.exe', 07:56:49 INFO - 'log_level': 'info', 07:56:49 INFO - 'log_name': 'talos', 07:56:49 INFO - 'log_to_console': True, 07:56:49 INFO - 'minidump_stackwalk_path': 'macosx64-minidump_stackwalk', 07:56:49 INFO - 'minidump_tooltool_manifest_path': 'config/tooltool-manifests/macosx64/releng.manifest', 07:56:49 INFO - 'opt_config_files': (), 07:56:49 INFO - 'pip_index': False, 07:56:49 INFO - 'postflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:56:49 INFO - 'cmd': ('bash', 07:56:49 INFO - '-c', 07:56:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:56:49 INFO - 'enabled': True, 07:56:49 INFO - 'halt_on_failure': False, 07:56:49 INFO - 'name': 'check_screen_resolution'},), 07:56:49 INFO - 'preflight_run_cmd_suites': ({'architectures': ('32bit', '64bit'), 07:56:49 INFO - 'cmd': ('bash', 07:56:49 INFO - '-c', 07:56:49 INFO - 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'), 07:56:49 INFO - 'enabled': True, 07:56:49 INFO - 'halt_on_failure': False, 07:56:49 INFO - 'name': 'check_screen_resolution'},), 07:56:49 INFO - 'run_cmd_checks_enabled': True, 07:56:49 INFO - 'suite': 'dromaeojs', 07:56:49 INFO - 'system_bits': '32', 07:56:49 INFO - 'talos_extra_options': ('--webServer', 'localhost'), 07:56:49 INFO - 'title': 't-yosemite-r7-0177', 07:56:49 INFO - 'tooltool_cache': '/builds/tooltool_cache', 07:56:49 INFO - 'use_talos_json': True, 07:56:49 INFO - 'virtualenv_path': '/builds/slave/test/build/venv', 07:56:49 INFO - 'volatile_config': {'actions': None, 'add_actions': None, 'no_actions': None}, 07:56:49 INFO - 'work_dir': 'build'} 07:56:49 INFO - [mozharness: 2017-05-05 14:56:49.131762Z] Running clobber step. 07:56:49 INFO - Running pre-action listener: _resource_record_pre_action 07:56:49 INFO - Running main action method: clobber 07:56:49 INFO - rmtree: /builds/slave/test/build 07:56:49 INFO - retry: Calling rmtree with args: ('/builds/slave/test/build',), kwargs: {}, attempt #1 07:56:51 INFO - Running post-action listener: _resource_record_post_action 07:56:51 INFO - [mozharness: 2017-05-05 14:56:51.565101Z] Finished clobber step (success) 07:56:51 INFO - [mozharness: 2017-05-05 14:56:51.565232Z] Running read-buildbot-config step. 07:56:51 INFO - Running pre-action listener: _resource_record_pre_action 07:56:51 INFO - Running main action method: read_buildbot_config 07:56:51 INFO - Using buildbot properties: 07:56:51 INFO - { 07:56:51 INFO - "project": "", 07:56:51 INFO - "product": "firefox", 07:56:51 INFO - "script_repo_revision": "production", 07:56:51 INFO - "builddir": "mozilla-central_yosemite_r7_test-dromaeojs", 07:56:51 INFO - "repository": "", 07:56:51 INFO - "buildername": "Rev7 MacOSX Yosemite 10.10.5 mozilla-central talos dromaeojs", 07:56:51 INFO - "buildid": "20170505061915", 07:56:51 INFO - "pgo_build": "False", 07:56:51 INFO - "basedir": "/builds/slave/test", 07:56:51 INFO - "buildnumber": 35, 07:56:51 INFO - "slavename": "t-yosemite-r7-0177", 07:56:51 INFO - "master": "http://buildbot-master134.bb.releng.scl3.mozilla.com:8201/", 07:56:51 INFO - "platform": "yosemite_r7", 07:56:51 INFO - "scheduler": "tests-mozilla-central-macosx64-talos", 07:56:51 INFO - "branch": "mozilla-central", 07:56:51 INFO - "repo_path": "mozilla-central", 07:56:51 INFO - "revision": "8872ad4d52b6b517dc9d2a9f62c5c75ceda18790", 07:56:51 INFO - "stage_platform": "macosx64", 07:56:51 INFO - "builduid": "2132191575764827a98b778f3c8898d3", 07:56:51 INFO - "slavebuilddir": "test" 07:56:51 INFO - } 07:56:51 INFO - Found installer url https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg. 07:56:51 INFO - Running post-action listener: _resource_record_post_action 07:56:51 INFO - [mozharness: 2017-05-05 14:56:51.568702Z] Finished read-buildbot-config step (success) 07:56:51 INFO - [mozharness: 2017-05-05 14:56:51.568831Z] Running download-and-extract step. 07:56:51 INFO - Running pre-action listener: _resource_record_pre_action 07:56:51 INFO - Running main action method: download_and_extract 07:56:51 INFO - mkdir: /builds/slave/test/build/tests 07:56:51 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')]} 07:56:51 INFO - trying https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.test_packages.json 07:56:51 INFO - Downloading https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/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 07:56:51 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/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 07:56:52 INFO - Downloaded 1325 bytes. 07:56:52 INFO - Reading from file /builds/slave/test/build/firefox-55.0a1.en-US.mac.test_packages.json 07:56:52 INFO - Using the following test package requirements: 07:56:52 INFO - {u'awsy': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:56:52 INFO - u'firefox-55.0a1.en-US.mac.awsy.tests.zip'], 07:56:52 INFO - u'common': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 07:56:52 INFO - u'cppunittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:56:52 INFO - u'firefox-55.0a1.en-US.mac.cppunittest.tests.zip'], 07:56:52 INFO - u'gtest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:56:52 INFO - u'firefox-55.0a1.en-US.mac.gtest.tests.zip'], 07:56:52 INFO - u'jittest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:56:52 INFO - u'jsshell-mac.zip'], 07:56:52 INFO - u'mochitest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:56:52 INFO - u'firefox-55.0a1.en-US.mac.mochitest.tests.zip'], 07:56:52 INFO - u'mozbase': [u'firefox-55.0a1.en-US.mac.common.tests.zip'], 07:56:52 INFO - u'reftest': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:56:52 INFO - u'firefox-55.0a1.en-US.mac.reftest.tests.zip'], 07:56:52 INFO - u'talos': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:56:52 INFO - u'firefox-55.0a1.en-US.mac.talos.tests.zip'], 07:56:52 INFO - u'web-platform': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:56:52 INFO - u'firefox-55.0a1.en-US.mac.web-platform.tests.zip'], 07:56:52 INFO - u'xpcshell': [u'firefox-55.0a1.en-US.mac.common.tests.zip', 07:56:52 INFO - u'firefox-55.0a1.en-US.mac.xpcshell.tests.zip']} 07:56:52 INFO - Downloading packages: [u'firefox-55.0a1.en-US.mac.common.tests.zip'] for test suite category: common 07:56:52 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 07:56:52 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:56:52 INFO - Fetch https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 07:56:54 INFO - Content-Length response header: 52701944 07:56:54 INFO - Bytes received: 52701944 07:57:10 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 07:57:10 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip 07:57:10 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip'}, attempt #1 07:57:10 INFO - Fetch https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.common.tests.zip into memory 07:57:12 INFO - Content-Length response header: 52701944 07:57:12 INFO - Bytes received: 52701944 07:57:28 INFO - Downloading and extracting to /builds/slave/test/build/tests these dirs * from https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip 07:57:28 INFO - retry: Calling fetch_url_into_memory with args: (), kwargs: {'url': u'https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip'}, attempt #1 07:57:28 INFO - Fetch https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.talos.tests.zip into memory 07:57:29 INFO - Content-Length response header: 14408809 07:57:29 INFO - Bytes received: 14408809 07:57:29 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:29 INFO - trying https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:57:29 INFO - Downloading https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg to /builds/slave/test/build/firefox-55.0a1.en-US.mac.dmg 07:57:29 INFO - retry: Calling _download_file with args: (), kwargs: {'url': 'https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/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 07:57:31 INFO - Downloaded 70883395 bytes. 07:57:31 INFO - Setting buildbot property build_url to https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:57:31 INFO - mkdir: /builds/slave/test/properties 07:57:31 INFO - Writing buildbot properties ['build_url'] to /builds/slave/test/properties/build_url 07:57:31 INFO - Writing to file /builds/slave/test/properties/build_url 07:57:31 INFO - Contents: 07:57:31 INFO - build_url:https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg 07:57:32 INFO - Running post-action listener: _resource_record_post_action 07:57:32 INFO - Running post-action listener: set_extra_try_arguments 07:57:32 INFO - [mozharness: 2017-05-05 14:57:32.588466Z] Finished download-and-extract step (success) 07:57:32 INFO - [mozharness: 2017-05-05 14:57:32.588593Z] Running populate-webroot step. 07:57:32 INFO - Running pre-action listener: _resource_record_pre_action 07:57:32 INFO - Running main action method: populate_webroot 07:57:32 INFO - {'extra_options': {'android': ['--apkPath=%(apk_path)s']}, 07:57:32 INFO - 'mobile-suites': {'remote-tp4m_nochrome': {'tests': ['tp4m']}, 07:57:32 INFO - 'remote-tsvgx': {'talos_options': ['--noChrome', 07:57:32 INFO - '--tppagecycles', 07:57:32 INFO - '7'], 07:57:32 INFO - 'tests': ['tsvgm']}}, 07:57:32 INFO - 'suites': {'chromez': {'talos_options': ['--disable-e10s'], 07:57:32 INFO - 'tests': ['tresize', 'tcanvasmark']}, 07:57:32 INFO - 'chromez-e10s': {'tests': ['tresize', 'tcanvasmark']}, 07:57:32 INFO - 'dromaeojs': {'talos_options': ['--disable-e10s'], 07:57:32 INFO - 'tests': ['dromaeo_css', 'kraken']}, 07:57:32 INFO - 'dromaeojs-e10s': {'tests': ['dromaeo_css', 'kraken']}, 07:57:32 INFO - 'g1': {'pagesets_name': 'tp5n.zip', 07:57:32 INFO - 'talos_options': ['--disable-e10s'], 07:57:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:57:32 INFO - 'g1-e10s': {'pagesets_name': 'tp5n.zip', 07:57:32 INFO - 'tests': ['tp5o_scroll', 'glterrain']}, 07:57:32 INFO - 'g2': {'pagesets_name': 'tp5n.zip', 07:57:32 INFO - 'talos_options': ['--disable-e10s'], 07:57:32 INFO - 'tests': ['damp', 'tps']}, 07:57:32 INFO - 'g2-e10s': {'pagesets_name': 'tp5n.zip', 07:57:32 INFO - 'tests': ['damp', 'tps']}, 07:57:32 INFO - 'g3': {'talos_options': ['--disable-e10s'], 07:57:32 INFO - 'tests': ['dromaeo_dom']}, 07:57:32 INFO - 'g3-e10s': {'tests': ['dromaeo_dom']}, 07:57:32 INFO - 'g4': {'talos_options': ['--disable-e10s'], 07:57:32 INFO - 'tests': ['basic_compositor_video', 'glvideo']}, 07:57:32 INFO - 'g4-e10s': {'tests': ['basic_compositor_video', 'glvideo']}, 07:57:32 INFO - 'other': {'talos_options': ['--disable-e10s'], 07:57:32 INFO - 'tests': ['a11yr', 07:57:32 INFO - 'ts_paint', 07:57:32 INFO - 'tpaint', 07:57:32 INFO - 'sessionrestore', 07:57:32 INFO - 'sessionrestore_no_auto_restore', 07:57:32 INFO - 'tabpaint']}, 07:57:32 INFO - 'other-e10s': {'tests': ['a11yr', 07:57:32 INFO - 'ts_paint', 07:57:32 INFO - 'tpaint', 07:57:32 INFO - 'sessionrestore', 07:57:32 INFO - 'sessionrestore_no_auto_restore', 07:57:32 INFO - 'tabpaint']}, 07:57:32 INFO - 'other-e10s_l64': {'tests': ['a11yr', 07:57:32 INFO - 'ts_paint', 07:57:32 INFO - 'tpaint', 07:57:32 INFO - 'sessionrestore', 07:57:32 INFO - 'sessionrestore_no_auto_restore', 07:57:32 INFO - 'tabpaint']}, 07:57:32 INFO - 'other-e10s_nol64': {'tests': ['a11yr', 07:57:32 INFO - 'ts_paint', 07:57:32 INFO - 'tpaint', 07:57:32 INFO - 'sessionrestore', 07:57:32 INFO - 'sessionrestore_no_auto_restore', 07:57:32 INFO - 'tabpaint']}, 07:57:32 INFO - 'other_l64': {'talos_options': ['--disable-e10s'], 07:57:32 INFO - 'tests': ['a11yr', 07:57:32 INFO - 'ts_paint', 07:57:32 INFO - 'tpaint', 07:57:32 INFO - 'sessionrestore', 07:57:32 INFO - 'sessionrestore_no_auto_restore', 07:57:32 INFO - 'tabpaint']}, 07:57:32 INFO - 'other_nol64': {'talos_options': ['--disable-e10s'], 07:57:32 INFO - 'tests': ['a11yr', 07:57:32 INFO - 'ts_paint', 07:57:32 INFO - 'tpaint', 07:57:32 INFO - 'sessionrestore', 07:57:32 INFO - 'sessionrestore_no_auto_restore', 07:57:32 INFO - 'tabpaint']}, 07:57:32 INFO - 'perf-reftest': {'tests': ['bloom_basic', 'bloom_basic_ref']}, 07:57:32 INFO - 'perf-reftest-e10s': {'tests': ['bloom_basic', 07:57:32 INFO - 'bloom_basic_ref']}, 07:57:32 INFO - 'svgr': {'talos_options': ['--disable-e10s'], 07:57:32 INFO - 'tests': ['tsvgx', 07:57:32 INFO - 'tsvgr_opacity', 07:57:32 INFO - 'tart', 07:57:32 INFO - 'tscrollx', 07:57:32 INFO - 'cart', 07:57:32 INFO - 'tsvg_static']}, 07:57:32 INFO - 'svgr-e10s': {'tests': ['tsvgx', 07:57:32 INFO - 'tsvgr_opacity', 07:57:32 INFO - 'tart', 07:57:32 INFO - 'tscrollx', 07:57:32 INFO - 'cart', 07:57:32 INFO - 'tsvg_static']}, 07:57:32 INFO - 'tp5o': {'pagesets_name': 'tp5n.zip', 07:57:32 INFO - 'talos_options': ['--disable-e10s'], 07:57:32 INFO - 'tests': ['tp5o']}, 07:57:32 INFO - 'tp5o-e10s': {'pagesets_name': 'tp5n.zip', 'tests': ['tp5o']}, 07:57:32 INFO - 'xperf': {'pagesets_name': 'tp5n.zip', 07:57:32 INFO - 'talos_options': ['--disable-e10s', 07:57:32 INFO - '--xperf_path', 07:57:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:57:32 INFO - 'tests': ['tp5n']}, 07:57:32 INFO - 'xperf-e10s': {'pagesets_name': 'tp5n.zip', 07:57:32 INFO - 'talos_options': ['--xperf_path', 07:57:32 INFO - '"c:/Program Files/Microsoft Windows Performance Toolkit/xperf.exe"'], 07:57:32 INFO - 'tests': ['tp5n']}}, 07:57:32 INFO - 'talos.zip': {'path': '', 07:57:32 INFO - 'url': 'http://talos-bundles.pvt.build.mozilla.org/zips/talos.a6052c33d420.zip'}} 07:57:32 INFO - Running post-action listener: _resource_record_post_action 07:57:32 INFO - [mozharness: 2017-05-05 14:57:32.607687Z] Finished populate-webroot step (success) 07:57:32 INFO - [mozharness: 2017-05-05 14:57:32.607800Z] Running create-virtualenv step. 07:57:32 INFO - Running pre-action listener: _resource_record_pre_action 07:57:32 INFO - Running main action method: create_virtualenv 07:57:32 INFO - Creating virtualenv /builds/slave/test/build/venv 07:57:32 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 07:57:32 INFO - Copy/paste: /tools/buildbot/bin/python /tools/misc-python/virtualenv.py --no-site-packages --distribute /builds/slave/test/build/venv 07:57:32 INFO - The --no-site-packages flag is deprecated; it is now the default behavior. 07:57:32 INFO - Using real prefix '/tools/python27' 07:57:32 INFO - New python executable in /builds/slave/test/build/venv/bin/python 07:57:33 INFO - Installing distribute.............................................................................................................................................................................................done. 07:57:36 INFO - Installing pip.................done. 07:57:36 INFO - Return code: 0 07:57:36 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', '--version'] 07:57:36 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip --version 07:57:36 INFO - Reading from file tmpfile_stdout 07:57:36 INFO - Output received: 07:57:36 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) 07:57:36 INFO - Installing pip>=1.5 into virtualenv /builds/slave/test/build/venv 07:57: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')]} 07:57:36 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:36 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57: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')]} 07:57:36 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:36 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57: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', 'pip>=1.5']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bc9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7d14945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba79d30>, '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 0x10b99fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba6ebe8>, '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.N9XodRpkAm/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.oIhna2G1pN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:57: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', 'pip>=1.5'] in /builds/slave/test/build 07:57: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 pip>=1.5 07:57:36 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9XodRpkAm/Render', 07:57:36 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:36 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:36 INFO - 'HOME': '/Users/cltbld', 07:57:36 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:36 INFO - 'LOGNAME': 'cltbld', 07:57:36 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:36 INFO - 'MOZ_NO_REMOTE': '1', 07:57:36 INFO - 'NO_EM_RESTART': '1', 07:57:36 INFO - 'PAGER': '/bin/cat', 07:57:36 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:36 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:36 INFO - 'PWD': '/builds/slave/test', 07:57:36 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:36 INFO - 'SHELL': '/bin/bash', 07:57:36 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIhna2G1pN/Listeners', 07:57:36 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:57:36 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:36 INFO - 'USER': 'cltbld', 07:57:36 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:36 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:36 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:36 INFO - 'XPC_FLAGS': '0x0', 07:57:36 INFO - 'XPC_SERVICE_NAME': '0', 07:57:36 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:37 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 07:57:37 INFO - Cleaning up... 07:57:37 INFO - Return code: 0 07:57:37 INFO - Installing psutil>=3.1.1 into virtualenv /builds/slave/test/build/venv 07:57:37 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')]} 07:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:37 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:37 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')]} 07:57:37 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:37 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:37 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 0x10bc9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7d14945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba79d30>, '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 0x10b99fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba6ebe8>, '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.N9XodRpkAm/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.oIhna2G1pN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:57:37 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 07:57:37 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 07:57:37 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9XodRpkAm/Render', 07:57:37 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:37 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:37 INFO - 'HOME': '/Users/cltbld', 07:57:37 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:37 INFO - 'LOGNAME': 'cltbld', 07:57:37 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:37 INFO - 'MOZ_NO_REMOTE': '1', 07:57:37 INFO - 'NO_EM_RESTART': '1', 07:57:37 INFO - 'PAGER': '/bin/cat', 07:57:37 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:37 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:37 INFO - 'PWD': '/builds/slave/test', 07:57:37 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:37 INFO - 'SHELL': '/bin/bash', 07:57:37 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIhna2G1pN/Listeners', 07:57:37 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:57:37 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:37 INFO - 'USER': 'cltbld', 07:57:37 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:37 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:37 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:37 INFO - 'XPC_FLAGS': '0x0', 07:57:37 INFO - 'XPC_SERVICE_NAME': '0', 07:57:37 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:37 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:37 INFO - Downloading/unpacking psutil>=3.1.1 07:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:37 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:37 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:37 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:37 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:39 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/psutil/setup.py) egg_info for package psutil 07:57:39 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:57:39 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:57:39 INFO - Installing collected packages: psutil 07:57:39 INFO - Running setup.py install for psutil 07:57:39 INFO - building 'psutil._psutil_osx' extension 07:57:39 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 07:57:40 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 07:57:40 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 07:57:40 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 07:57:40 INFO - building 'psutil._psutil_posix' extension 07:57:40 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 07:57:40 WARNING - psutil/_psutil_posix.c:403:11: warning: implicit declaration of function 'ioctl' is invalid in C99 [-Wimplicit-function-declaration] 07:57:40 INFO - ret = ioctl(sock, SIOCGIFFLAGS, &ifr); 07:57:40 INFO - ^ 07:57:40 INFO - 1 warning generated. 07:57:40 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 07:57:40 INFO - warning: no previously-included files matching '*' found under directory 'docs/_build' 07:57:40 INFO - warning: manifest_maker: MANIFEST.in, line 18: 'recursive-include' expects ... 07:57:40 INFO - Successfully installed psutil 07:57:40 INFO - Cleaning up... 07:57:40 INFO - Return code: 0 07:57:40 INFO - Installing mozsystemmonitor==0.3 into virtualenv /builds/slave/test/build/venv 07:57: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')]} 07:57:40 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:40 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57: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')]} 07:57:40 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:40 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57: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', 'mozsystemmonitor==0.3']], kwargs: {'error_level': 'warning', 'error_list': [{'substr': 'not found or a compiler error:', 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x10bc9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7d14945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba79d30>, '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 0x10b99fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba6ebe8>, '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.N9XodRpkAm/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.oIhna2G1pN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:57: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', 'mozsystemmonitor==0.3'] in /builds/slave/test/build 07:57: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 mozsystemmonitor==0.3 07:57:40 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9XodRpkAm/Render', 07:57:40 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:40 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:40 INFO - 'HOME': '/Users/cltbld', 07:57:40 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:40 INFO - 'LOGNAME': 'cltbld', 07:57:40 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:40 INFO - 'MOZ_NO_REMOTE': '1', 07:57:40 INFO - 'NO_EM_RESTART': '1', 07:57:40 INFO - 'PAGER': '/bin/cat', 07:57:40 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:40 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:40 INFO - 'PWD': '/builds/slave/test', 07:57:40 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:40 INFO - 'SHELL': '/bin/bash', 07:57:40 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIhna2G1pN/Listeners', 07:57:40 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:57:40 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:40 INFO - 'USER': 'cltbld', 07:57:40 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:40 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:40 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:40 INFO - 'XPC_FLAGS': '0x0', 07:57:40 INFO - 'XPC_SERVICE_NAME': '0', 07:57:40 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:41 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:41 INFO - Downloading/unpacking mozsystemmonitor==0.3 07:57: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 07:57: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 07:57: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 07:57: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 07:57: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 07:57: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 07:57:43 INFO - Downloading mozsystemmonitor-0.3.tar.gz 07:57:43 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/mozsystemmonitor/setup.py) egg_info for package mozsystemmonitor 07:57:43 INFO - Requirement already satisfied (use --upgrade to upgrade): psutil>=3.1.1 in ./venv/lib/python2.7/site-packages (from mozsystemmonitor==0.3) 07:57:43 INFO - Installing collected packages: mozsystemmonitor 07:57:43 INFO - Running setup.py install for mozsystemmonitor 07:57:43 INFO - Successfully installed mozsystemmonitor 07:57:43 INFO - Cleaning up... 07:57:43 INFO - Return code: 0 07:57:43 INFO - Installing jsonschema==2.5.1 into virtualenv /builds/slave/test/build/venv 07:57:43 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:43 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:44 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57: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')]} 07:57:44 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:44 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:44 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 0x10bc9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7d14945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba79d30>, '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 0x10b99fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba6ebe8>, '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.N9XodRpkAm/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.oIhna2G1pN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:57:44 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 07:57:44 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 07:57:44 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9XodRpkAm/Render', 07:57:44 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:44 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:44 INFO - 'HOME': '/Users/cltbld', 07:57:44 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:44 INFO - 'LOGNAME': 'cltbld', 07:57:44 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:44 INFO - 'MOZ_NO_REMOTE': '1', 07:57:44 INFO - 'NO_EM_RESTART': '1', 07:57:44 INFO - 'PAGER': '/bin/cat', 07:57:44 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:44 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:44 INFO - 'PWD': '/builds/slave/test', 07:57:44 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:44 INFO - 'SHELL': '/bin/bash', 07:57:44 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIhna2G1pN/Listeners', 07:57:44 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:57:44 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:44 INFO - 'USER': 'cltbld', 07:57:44 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:44 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:44 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:44 INFO - 'XPC_FLAGS': '0x0', 07:57:44 INFO - 'XPC_SERVICE_NAME': '0', 07:57:44 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:44 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:44 INFO - Downloading/unpacking jsonschema==2.5.1 07:57:44 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 07:57:44 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 07:57:44 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 07:57:44 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 07:57:44 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 07:57:44 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 07:57:46 INFO - Downloading jsonschema-2.5.1-py2.py3-none-any.whl 07:57:46 INFO - Downloading/unpacking functools32 (from jsonschema==2.5.1) 07:57:46 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 07:57:46 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 07:57:46 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 07:57:46 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 07:57:46 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 07:57:46 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 07:57:46 INFO - Downloading functools32-3.2.3-2.tar.gz 07:57:46 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/functools32/setup.py) egg_info for package functools32 07:57:46 INFO - warning: no files found matching '*.txt' 07:57:46 INFO - no previously-included directories found matching 'build' 07:57:46 INFO - no previously-included directories found matching 'dist' 07:57:46 INFO - no previously-included directories found matching '.git*' 07:57:46 INFO - Installing collected packages: jsonschema, functools32 07:57:46 INFO - Running setup.py install for functools32 07:57:46 INFO - warning: no files found matching '*.txt' 07:57:46 INFO - no previously-included directories found matching 'build' 07:57:46 INFO - no previously-included directories found matching 'dist' 07:57:46 INFO - no previously-included directories found matching '.git*' 07:57:46 INFO - Successfully installed jsonschema functools32 07:57:46 INFO - Cleaning up... 07:57:46 INFO - Return code: 0 07:57:46 INFO - Installing functools32==3.2.3-2 into virtualenv /builds/slave/test/build/venv 07:57:46 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')]} 07:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:46 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')]} 07:57:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:46 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 0x10bc9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7d14945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba79d30>, '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 0x10b99fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba6ebe8>, '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.N9XodRpkAm/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.oIhna2G1pN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:57:46 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 07:57:46 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 07:57:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9XodRpkAm/Render', 07:57:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:46 INFO - 'HOME': '/Users/cltbld', 07:57:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:46 INFO - 'LOGNAME': 'cltbld', 07:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:46 INFO - 'MOZ_NO_REMOTE': '1', 07:57:46 INFO - 'NO_EM_RESTART': '1', 07:57:46 INFO - 'PAGER': '/bin/cat', 07:57:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:46 INFO - 'PWD': '/builds/slave/test', 07:57:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:46 INFO - 'SHELL': '/bin/bash', 07:57:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIhna2G1pN/Listeners', 07:57:46 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:57:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:46 INFO - 'USER': 'cltbld', 07:57:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:46 INFO - 'XPC_FLAGS': '0x0', 07:57:46 INFO - 'XPC_SERVICE_NAME': '0', 07:57:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:46 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:46 INFO - Requirement already satisfied (use --upgrade to upgrade): functools32==3.2.3-2 in ./venv/lib/python2.7/site-packages 07:57:46 INFO - Cleaning up... 07:57:46 INFO - Return code: 0 07:57:46 INFO - Installing blobuploader==1.2.4 into virtualenv /builds/slave/test/build/venv 07:57:46 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')]} 07:57:46 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:46 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:46 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')]} 07:57:46 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:46 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:46 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 0x10bc9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7d14945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba79d30>, '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 0x10b99fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba6ebe8>, '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.N9XodRpkAm/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.oIhna2G1pN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:57:46 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 07:57:46 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 07:57:46 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9XodRpkAm/Render', 07:57:46 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:46 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:46 INFO - 'HOME': '/Users/cltbld', 07:57:46 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:46 INFO - 'LOGNAME': 'cltbld', 07:57:46 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:46 INFO - 'MOZ_NO_REMOTE': '1', 07:57:46 INFO - 'NO_EM_RESTART': '1', 07:57:46 INFO - 'PAGER': '/bin/cat', 07:57:46 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:46 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:46 INFO - 'PWD': '/builds/slave/test', 07:57:46 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:46 INFO - 'SHELL': '/bin/bash', 07:57:46 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIhna2G1pN/Listeners', 07:57:46 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:57:46 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:46 INFO - 'USER': 'cltbld', 07:57:46 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:46 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:46 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:46 INFO - 'XPC_FLAGS': '0x0', 07:57:46 INFO - 'XPC_SERVICE_NAME': '0', 07:57:46 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:47 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:47 INFO - Downloading/unpacking blobuploader==1.2.4 07:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:47 INFO - http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:47 INFO - http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com has it available 07:57:47 INFO - http://pypi.pvt.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pvt.build.mozilla.org has it available 07:57:47 INFO - http://pypi.pub.build.mozilla.org/pub uses an insecure transport scheme (http). Consider using https if pypi.pub.build.mozilla.org has it available 07:57:48 INFO - Downloading blobuploader-1.2.4.tar.gz 07:57:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blobuploader/setup.py) egg_info for package blobuploader 07:57:48 INFO - Downloading/unpacking requests==1.2.3. (from blobuploader==1.2.4) 07:57:48 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 07:57:48 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 07:57:48 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 07:57:48 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 07:57:48 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 07:57:48 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 07:57:48 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/requests/setup.py) egg_info for package requests 07:57:49 INFO - Downloading/unpacking docopt==0.6.1 (from blobuploader==1.2.4) 07:57:49 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 07:57:49 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 07:57:49 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 07:57:49 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 07:57:49 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 07:57:49 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 07:57:49 INFO - Downloading docopt-0.6.1.tar.gz 07:57:49 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/docopt/setup.py) egg_info for package docopt 07:57:49 INFO - Installing collected packages: blobuploader, requests, docopt 07:57:49 INFO - Running setup.py install for blobuploader 07:57:49 INFO - changing mode of build/scripts-2.7/blobberc.py from 664 to 775 07:57:49 INFO - changing mode of /builds/slave/test/build/venv/bin/blobberc.py to 775 07:57:49 INFO - Running setup.py install for requests 07:57:50 INFO - Running setup.py install for docopt 07:57:50 INFO - Successfully installed blobuploader requests docopt 07:57:50 INFO - Cleaning up... 07:57:50 INFO - Return code: 0 07:57:50 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:50 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:50 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:50 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:50 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:50 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:50 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 0x10bc9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7d14945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba79d30>, '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 0x10b99fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba6ebe8>, '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.N9XodRpkAm/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.oIhna2G1pN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:57:50 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 07:57:50 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 07:57:50 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9XodRpkAm/Render', 07:57:50 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:50 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:50 INFO - 'HOME': '/Users/cltbld', 07:57:50 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:50 INFO - 'LOGNAME': 'cltbld', 07:57:50 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:50 INFO - 'MOZ_NO_REMOTE': '1', 07:57:50 INFO - 'NO_EM_RESTART': '1', 07:57:50 INFO - 'PAGER': '/bin/cat', 07:57:50 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:50 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:50 INFO - 'PWD': '/builds/slave/test', 07:57:50 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:50 INFO - 'SHELL': '/bin/bash', 07:57:50 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIhna2G1pN/Listeners', 07:57:50 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:57:50 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:50 INFO - 'USER': 'cltbld', 07:57:50 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:50 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:50 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:50 INFO - 'XPC_FLAGS': '0x0', 07:57:50 INFO - 'XPC_SERVICE_NAME': '0', 07:57:50 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:50 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:57:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-f244M4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:57:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-gW570M-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:57:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-gp75VT-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:57:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-nJ2bzH-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:57:50 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:57:50 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-xzdjoh-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:57:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-n3ihPK-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:57:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Wf809E-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:57:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-yHy3aZ-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:57:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Zhy753-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:57:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Qx74AR-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:57:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-dC6TnL-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:57:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-wokcxn-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:57:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-wzTlEX-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:57:51 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:57:51 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-O6apmw-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:52 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-rXlmhl-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:57:52 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-crdWyb-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:57:52 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:57:52 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-gy0TPE-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:57:52 INFO - Installing collected packages: manifestparser, mozcrash, mozdebug, mozdevice, mozfile, mozhttpd, mozinfo, mozInstall, mozleak, mozlog, moznetwork, mozprocess, mozprofile, mozrunner, mozscreenshot, moztest, mozversion 07:57:52 INFO - Running setup.py install for manifestparser 07:57:52 INFO - Installing manifestparser script to /builds/slave/test/build/venv/bin 07:57:52 INFO - Running setup.py install for mozcrash 07:57:52 INFO - Running setup.py install for mozdebug 07:57:52 INFO - Running setup.py install for mozdevice 07:57:52 INFO - Installing dm script to /builds/slave/test/build/venv/bin 07:57:52 INFO - Running setup.py install for mozfile 07:57:53 INFO - Running setup.py install for mozhttpd 07:57:53 INFO - Installing mozhttpd script to /builds/slave/test/build/venv/bin 07:57:53 INFO - Running setup.py install for mozinfo 07:57:53 INFO - Installing mozinfo script to /builds/slave/test/build/venv/bin 07:57:53 INFO - Running setup.py install for mozInstall 07:57:53 INFO - Installing moz_remove_from_system script to /builds/slave/test/build/venv/bin 07:57:53 INFO - Installing mozuninstall script to /builds/slave/test/build/venv/bin 07:57:53 INFO - Installing mozinstall script to /builds/slave/test/build/venv/bin 07:57:53 INFO - Installing moz_add_to_system script to /builds/slave/test/build/venv/bin 07:57:53 INFO - Running setup.py install for mozleak 07:57:53 INFO - Running setup.py install for mozlog 07:57:53 INFO - Installing structlog script to /builds/slave/test/build/venv/bin 07:57:53 INFO - Running setup.py install for moznetwork 07:57:53 INFO - Installing moznetwork script to /builds/slave/test/build/venv/bin 07:57:53 INFO - Running setup.py install for mozprocess 07:57:54 INFO - Running setup.py install for mozprofile 07:57:54 INFO - Installing mozprofile script to /builds/slave/test/build/venv/bin 07:57:54 INFO - Installing diff-profiles script to /builds/slave/test/build/venv/bin 07:57:54 INFO - Installing view-profile script to /builds/slave/test/build/venv/bin 07:57:54 INFO - Running setup.py install for mozrunner 07:57:54 INFO - Installing mozrunner script to /builds/slave/test/build/venv/bin 07:57:54 INFO - Running setup.py install for mozscreenshot 07:57:54 INFO - Running setup.py install for moztest 07:57:54 INFO - Running setup.py install for mozversion 07:57:54 INFO - Installing mozversion script to /builds/slave/test/build/venv/bin 07:57:54 INFO - Successfully installed manifestparser mozcrash mozdebug mozdevice mozfile mozhttpd mozinfo mozInstall mozleak mozlog moznetwork mozprocess mozprofile mozrunner mozscreenshot moztest mozversion 07:57:54 INFO - Cleaning up... 07:57:54 INFO - Return code: 0 07:57:54 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:54 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:54 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:54 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:54 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:54 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:54 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 0x10bc9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7d14945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba79d30>, '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 0x10b99fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba6ebe8>, '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.N9XodRpkAm/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.oIhna2G1pN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:57:54 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 07:57:54 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 07:57:54 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9XodRpkAm/Render', 07:57:54 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:54 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:54 INFO - 'HOME': '/Users/cltbld', 07:57:54 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:54 INFO - 'LOGNAME': 'cltbld', 07:57:54 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:54 INFO - 'MOZ_NO_REMOTE': '1', 07:57:54 INFO - 'NO_EM_RESTART': '1', 07:57:54 INFO - 'PAGER': '/bin/cat', 07:57:54 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:54 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:54 INFO - 'PWD': '/builds/slave/test', 07:57:54 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:54 INFO - 'SHELL': '/bin/bash', 07:57:54 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIhna2G1pN/Listeners', 07:57:54 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:57:54 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:54 INFO - 'USER': 'cltbld', 07:57:54 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:54 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:54 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:54 INFO - 'XPC_FLAGS': '0x0', 07:57:54 INFO - 'XPC_SERVICE_NAME': '0', 07:57:54 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:55 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/manifestparser 07:57:55 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-XJWOo1-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/manifestparser 07:57:55 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)) 07:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozcrash 07:57:55 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-8p7xSz-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozcrash 07:57:55 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)) 07:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdebug 07:57:55 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-3a2Uv4-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdebug 07:57:55 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)) 07:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozdevice 07:57:55 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Y9xDR3-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozdevice 07:57:55 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)) 07:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozfile 07:57:55 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-8cMt9K-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozfile 07:57:55 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)) 07:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozhttpd 07:57:55 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Or8lWj-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozhttpd 07:57:55 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)) 07:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinfo 07:57:55 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-LJbWtd-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinfo 07:57:55 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)) 07:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozinstall 07:57:55 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-3OnsUa-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozinstall 07:57:55 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)) 07:57:55 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozleak 07:57:55 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-ZSLcfv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozleak 07:57:56 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)) 07:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozlog 07:57:56 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Oh7QWr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozlog 07:57:56 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)) 07:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moznetwork 07:57:56 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-HqA46m-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moznetwork 07:57:56 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)) 07:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprocess 07:57:56 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-8MBMdr-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprocess 07:57:56 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)) 07:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozprofile 07:57:56 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-sOGqA5-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozprofile 07:57:56 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)) 07:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozrunner 07:57:56 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-VQl_3y-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozrunner 07:57:56 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)) 07:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:56 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-BsDN_Z-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozscreenshot 07:57:56 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)) 07:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/moztest 07:57:56 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-Q5FD43-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/moztest 07:57:56 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)) 07:57:56 INFO - Unpacking /builds/slave/test/build/tests/mozbase/mozversion 07:57:56 INFO - Running setup.py (path:/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/pip-GL84bv-build/setup.py) egg_info for package from file:///builds/slave/test/build/tests/mozbase/mozversion 07:57:56 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)) 07:57:56 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)) 07:57:56 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)) 07:57:56 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)) 07:57:56 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)) 07:57:56 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)) 07:57:56 INFO - Downloading/unpacking blessings>=1.3 (from mozlog==3.4->-r /builds/slave/test/build/tests/config/mozbase_requirements.txt (line 10)) 07:57:56 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 07:57:56 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 07:57:56 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 07:57:56 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 07:57:56 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 07:57:56 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 07:57:58 INFO - Downloading blessings-1.6.tar.gz 07:57:58 INFO - Running setup.py (path:/builds/slave/test/build/venv/build/blessings/setup.py) egg_info for package blessings 07:57:58 INFO - Installing collected packages: blessings 07:57:58 INFO - Running setup.py install for blessings 07:57:58 INFO - Successfully installed blessings 07:57:58 INFO - Cleaning up... 07:57:58 INFO - Return code: 0 07:57:58 INFO - Done creating virtualenv /builds/slave/test/build/venv. 07:57:58 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:57:58 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:57:58 INFO - Reading from file tmpfile_stdout 07:57:58 INFO - Current package versions: 07:57:58 INFO - blessings == 1.6 07:57:58 INFO - blobuploader == 1.2.4 07:57:58 INFO - docopt == 0.6.1 07:57:58 INFO - functools32 == 3.2.3-2 07:57:58 INFO - jsonschema == 2.5.1 07:57:58 INFO - manifestparser == 1.1 07:57:58 INFO - mozInstall == 1.12 07:57:58 INFO - mozcrash == 1.0 07:57:58 INFO - mozdebug == 0.1 07:57:58 INFO - mozdevice == 0.50 07:57:58 INFO - mozfile == 1.2 07:57:58 INFO - mozhttpd == 0.7 07:57:58 INFO - mozinfo == 0.9 07:57:58 INFO - mozleak == 0.1 07:57:58 INFO - mozlog == 3.4 07:57:58 INFO - moznetwork == 0.27 07:57:58 INFO - mozprocess == 0.25 07:57:58 INFO - mozprofile == 0.28 07:57:58 INFO - mozrunner == 6.13 07:57:58 INFO - mozscreenshot == 0.1 07:57:58 INFO - mozsystemmonitor == 0.3 07:57:58 INFO - moztest == 0.8 07:57:58 INFO - mozversion == 1.4 07:57:58 INFO - psutil == 3.1.1 07:57:58 INFO - requests == 1.2.3 07:57:58 INFO - wsgiref == 0.1.2 07:57:58 INFO - Installing None into virtualenv /builds/slave/test/build/venv 07:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:58 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:58 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:58 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:58 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:58 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:58 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 0x10bc9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7d14945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba79d30>, '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 0x10b99fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba6ebe8>, '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.N9XodRpkAm/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.oIhna2G1pN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:57:58 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 07:57:58 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 07:57:58 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9XodRpkAm/Render', 07:57:58 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:58 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:58 INFO - 'HOME': '/Users/cltbld', 07:57:58 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:58 INFO - 'LOGNAME': 'cltbld', 07:57:58 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:58 INFO - 'MOZ_NO_REMOTE': '1', 07:57:58 INFO - 'NO_EM_RESTART': '1', 07:57:58 INFO - 'PAGER': '/bin/cat', 07:57:58 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:58 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:58 INFO - 'PWD': '/builds/slave/test', 07:57:58 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:58 INFO - 'SHELL': '/bin/bash', 07:57:58 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIhna2G1pN/Listeners', 07:57:58 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:57:58 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:58 INFO - 'USER': 'cltbld', 07:57:58 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:58 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:58 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:58 INFO - 'XPC_FLAGS': '0x0', 07:57:58 INFO - 'XPC_SERVICE_NAME': '0', 07:57:58 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:59 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)) 07:57:59 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)) 07:57:59 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)) 07:57:59 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)) 07:57:59 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)) 07:57:59 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)) 07:57:59 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)) 07:57:59 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)) 07:57:59 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)) 07:57:59 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)) 07:57:59 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)) 07:57:59 INFO - Cleaning up... 07:57:59 INFO - Return code: 0 07:57:59 INFO - Installing jsonschema into virtualenv /builds/slave/test/build/venv 07:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:59 INFO - http://pypi.pvt.build.mozilla.org/pub matches http://pypi.pvt.build.mozilla.org 07:57:59 INFO - URL Candidate: http://pypi.pvt.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:59 INFO - proxxy config: {'regions': ['.use1.', '.usw2.', '.scl3'], 'instances': ['proxxy1.srv.releng.use1.mozilla.com', 'proxxy1.srv.releng.usw2.mozilla.com', 'proxxy1.srv.releng.scl3.mozilla.com'], 'urls': [('http://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp.mozilla.org', 'ftp.mozilla.org'), ('https://ftp-ssl.mozilla.org', 'ftp.mozilla.org'), ('http://pypi.pvt.build.mozilla.org', 'pypi.pvt.build.mozilla.org'), ('http://pypi.pub.build.mozilla.org', 'pypi.pub.build.mozilla.org')]} 07:57:59 INFO - http://pypi.pub.build.mozilla.org/pub matches http://pypi.pub.build.mozilla.org 07:57:59 INFO - URL Candidate: http://pypi.pub.build.mozilla.org.proxxy1.srv.releng.scl3.mozilla.com/pub 07:57:59 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 0x10bc9bb70>, 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10bc9e768>, 'level': 'warning'}, {'regex': <_sre.SRE_Pattern object at 0x7fb7d14945e0>, 'level': 'debug'}, {'substr': 'command not found', 'level': 'error'}, {'regex': <_sre.SRE_Pattern object at 0x10ba79d30>, '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 0x10b99fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba6ebe8>, '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.N9XodRpkAm/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.oIhna2G1pN/Listeners', 'SHELL': '/bin/bash', 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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 07:57:59 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 07:57:59 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 07:57:59 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9XodRpkAm/Render', 07:57:59 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:57:59 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:57:59 INFO - 'HOME': '/Users/cltbld', 07:57:59 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:57:59 INFO - 'LOGNAME': 'cltbld', 07:57:59 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:57:59 INFO - 'MOZ_NO_REMOTE': '1', 07:57:59 INFO - 'NO_EM_RESTART': '1', 07:57:59 INFO - 'PAGER': '/bin/cat', 07:57:59 INFO - 'PATH': '/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:57:59 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:57:59 INFO - 'PWD': '/builds/slave/test', 07:57:59 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:57:59 INFO - 'SHELL': '/bin/bash', 07:57:59 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIhna2G1pN/Listeners', 07:57:59 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:57:59 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:57:59 INFO - 'USER': 'cltbld', 07:57:59 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:57:59 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:57:59 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:57:59 INFO - 'XPC_FLAGS': '0x0', 07:57:59 INFO - 'XPC_SERVICE_NAME': '0', 07:57:59 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:57:59 INFO - Ignoring indexes: https://pypi.python.org/simple/ 07:57:59 INFO - Requirement already satisfied (use --upgrade to upgrade): jsonschema in ./venv/lib/python2.7/site-packages 07:57:59 INFO - Cleaning up... 07:57:59 INFO - Return code: 0 07:57:59 INFO - Running post-action listener: _resource_record_post_action 07:57:59 INFO - Running post-action listener: _start_resource_monitoring 07:57:59 INFO - Starting resource monitoring. 07:57:59 INFO - [mozharness: 2017-05-05 14:57:59.419445Z] Finished create-virtualenv step (success) 07:57:59 INFO - [mozharness: 2017-05-05 14:57:59.420425Z] Running install step. 07:57:59 INFO - Running pre-action listener: _resource_record_pre_action 07:57:59 INFO - Running main action method: install 07:57:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/pip', 'freeze'] 07:57:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/pip freeze 07:57:59 INFO - Reading from file tmpfile_stdout 07:57:59 INFO - Detecting whether we're running mozinstall >=1.0... 07:57:59 INFO - Getting output from command: ['/builds/slave/test/build/venv/bin/mozinstall', '-h'] 07:57:59 INFO - Copy/paste: /builds/slave/test/build/venv/bin/mozinstall -h 07:57:59 INFO - Reading from file tmpfile_stdout 07:57:59 INFO - Output received: 07:57:59 INFO - Usage: mozinstall [options] installer 07:57:59 INFO - Options: 07:57:59 INFO - -h, --help show this help message and exit 07:57:59 INFO - -d DEST, --destination=DEST 07:57:59 INFO - Directory to install application into. [default: 07:57:59 INFO - "/builds/slave/test"] 07:57:59 INFO - --app=APP Application being installed. [default: firefox] 07:57:59 INFO - mkdir: /builds/slave/test/build/application 07:57:59 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'] 07:57:59 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 07:58:19 INFO - Reading from file tmpfile_stdout 07:58:19 INFO - Output received: 07:58:19 INFO - /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox 07:58:19 INFO - Running post-action listener: _resource_record_post_action 07:58:19 INFO - [mozharness: 2017-05-05 14:58:19.687655Z] Finished install step (success) 07:58:19 INFO - [mozharness: 2017-05-05 14:58:19.687794Z] Running run-tests step. 07:58:19 INFO - Running pre-action listener: _resource_record_pre_action 07:58:19 INFO - Running main action method: run_tests 07:58:19 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 07:58:19 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 07:58:19 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 07:58:19 INFO - 2017-05-05 07:58:19.702 screenresolution[1629:7526] starting screenresolution argv=screenresolution get 07:58:19 INFO - 2017-05-05 07:58:19.705 screenresolution[1629:7526] Display 0: 1600x1200x32@60 07:58:19 INFO - 2017-05-05 07:58:19.710 screenresolution[1630:7529] starting screenresolution argv=screenresolution list 07:58:19 INFO - Available Modes on Display 0 07:58:19 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 07:58:19 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 07:58:19 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 07:58:19 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 07:58:19 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 07:58:19 INFO - Intel Iris: 07:58:19 INFO - Chipset Model: Intel Iris 07:58:19 INFO - Type: GPU 07:58:19 INFO - Bus: Built-In 07:58:19 INFO - VRAM (Dynamic, Max): 1536 MB 07:58:19 INFO - Vendor: Intel (0x8086) 07:58:19 INFO - Device ID: 0x0a2e 07:58:19 INFO - Revision ID: 0x0009 07:58:19 INFO - Displays: 07:58:19 INFO - Display: 07:58:19 INFO - Resolution: 1600 x 1200 @ 60 Hz 07:58:19 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 07:58:19 INFO - Display Serial Number: 1600x1200 60 07:58:19 INFO - Main Display: Yes 07:58:19 INFO - Mirror: Off 07:58:19 INFO - Online: Yes 07:58:19 INFO - Rotation: Supported 07:58:19 INFO - Return code: 0 07:58:19 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '--version'] 07:58:19 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python --version 07:58:19 INFO - Python 2.7.3 07:58:19 INFO - Return code: 0 07:58:19 INFO - grabbing minidump binary from tooltool 07:58:19 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')]} 07:58:19 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 0x10ba79d30>, '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 0x10b99fdb0>, 'level': 'critical'}, {'regex': <_sre.SRE_Pattern object at 0x10ba6ebe8>, 'level': 'critical'}, {'substr': 'ERROR - ', 'level': 'error'}], 'cwd': '/builds/slave/test/build', 'privileged': False}, attempt #1 07:58:19 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 07:58:19 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 07:58:19 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 07:58:20 INFO - INFO - File macosx64-minidump_stackwalk retrieved from local cache /builds/tooltool_cache 07:58:20 INFO - Return code: 0 07:58:20 INFO - Chmoding /builds/slave/test/build/macosx64-minidump_stackwalk to 0755 07:58:20 INFO - mkdir: /builds/slave/test/build/blobber_upload_dir 07:58:20 INFO - ENV: MOZ_UPLOAD_DIR is now /builds/slave/test/build/blobber_upload_dir 07:58:20 INFO - ENV: RUST_BACKTRACE is now 1 07:58:20 INFO - ENV: MINIDUMP_STACKWALK is now /builds/slave/test/build/macosx64-minidump_stackwalk 07:58:20 INFO - ENV: MINIDUMP_SAVE_PATH is now /builds/slave/test/build/blobber_upload_dir 07:58:20 INFO - Running command: ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--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 07:58:20 INFO - Copy/paste: /builds/slave/test/build/venv/bin/python /builds/slave/test/build/tests/talos/talos/run_tests.py --branchName Firefox --suite dromaeojs --executablePath /builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox --symbolsPath https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip --title t-yosemite-r7-0177 --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 07:58:20 INFO - Using env: {'Apple_PubSub_Socket_Render': '/private/tmp/com.apple.launchd.N9XodRpkAm/Render', 07:58:20 INFO - 'GIT_SHARE_BASE_DIR': '/builds/git-shared', 07:58:20 INFO - 'HG_SHARE_BASE_DIR': '/builds/hg-shared', 07:58:20 INFO - 'HOME': '/Users/cltbld', 07:58:20 INFO - 'IDLEIZER_DISABLE_SHUTDOWN': 'true', 07:58:20 INFO - 'LOGNAME': 'cltbld', 07:58:20 INFO - 'MINIDUMP_SAVE_PATH': '/builds/slave/test/build/blobber_upload_dir', 07:58:20 INFO - 'MINIDUMP_STACKWALK': '/builds/slave/test/build/macosx64-minidump_stackwalk', 07:58:20 INFO - 'MOZ_CRASHREPORTER_NO_REPORT': '1', 07:58:20 INFO - 'MOZ_NO_REMOTE': '1', 07:58:20 INFO - 'MOZ_UPLOAD_DIR': '/builds/slave/test/build/blobber_upload_dir', 07:58:20 INFO - 'NO_EM_RESTART': '1', 07:58:20 INFO - 'PAGER': '/bin/cat', 07:58:20 INFO - 'PATH': '/builds/slave/test/build/venv/bin:/usr/local/sbin:/usr/local/bin:/usr/sbin:/usr/bin:/sbin:/bin:/usr/bin/X11', 07:58:20 INFO - 'PROPERTIES_FILE': '/builds/slave/test/buildprops.json', 07:58:20 INFO - 'PWD': '/builds/slave/test', 07:58:20 INFO - 'PYTHONPATH': '/builds/slave/test/build/tests/talos', 07:58:20 INFO - 'RUNNER_CONFIG_CMD': '/opt/runner/bin/python2.7 /opt/runner/bin/runner -c /opt/runner/runner.cfg', 07:58:20 INFO - 'RUST_BACKTRACE': '1', 07:58:20 INFO - 'SHELL': '/bin/bash', 07:58:20 INFO - 'SSH_AUTH_SOCK': '/private/tmp/com.apple.launchd.oIhna2G1pN/Listeners', 07:58:20 INFO - 'TMPDIR': '/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/', 07:58:20 INFO - 'TWISTD_LOG_PATH': '/builds/slave/twistd.log', 07:58:20 INFO - 'USER': 'cltbld', 07:58:20 INFO - 'VERSIONER_PYTHON_PREFER_32_BIT': 'no', 07:58:20 INFO - 'VERSIONER_PYTHON_VERSION': '2.7', 07:58:20 INFO - 'XPCOM_DEBUG_BREAK': 'warn', 07:58:20 INFO - 'XPC_FLAGS': '0x0', 07:58:20 INFO - 'XPC_SERVICE_NAME': '0', 07:58:20 INFO - '__CF_USER_TEXT_ENCODING': '0x1C:0:0'} 07:58:20 INFO - Calling ['/builds/slave/test/build/venv/bin/python', '/builds/slave/test/build/tests/talos/talos/run_tests.py', '--branchName', 'Firefox', '--suite', 'dromaeojs', '--executablePath', '/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox', '--symbolsPath', 'https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.crashreporter-symbols.zip', '--title', 't-yosemite-r7-0177', '--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 07:58:20 INFO - mozversion application_buildid: 20170505061915 07:58:20 INFO - mozversion application_changeset: 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 07:58:20 INFO - mozversion application_display_name: Nightly 07:58:20 INFO - mozversion application_id: {ec8030f7-c20a-464f-9b0e-13a3a9e97384} 07:58:20 INFO - mozversion application_name: Firefox 07:58:20 INFO - mozversion application_remotingname: firefox 07:58:20 INFO - mozversion application_repository: https://hg.mozilla.org/mozilla-central 07:58:20 INFO - mozversion application_vendor: Mozilla 07:58:20 INFO - mozversion application_version: 55.0a1 07:58:20 INFO - mozversion platform_buildid: 20170505061915 07:58:20 INFO - mozversion platform_changeset: 8872ad4d52b6b517dc9d2a9f62c5c75ceda18790 07:58:20 INFO - mozversion platform_repository: https://hg.mozilla.org/mozilla-central 07:58:20 INFO - mozversion platform_version: 55.0a1 07:58:20 INFO - using testdate: 1493996300 07:58:20 INFO - actual date: 1493996300 07:58:20 INFO - starting webserver on 'localhost:49243' 07:58:20 INFO - SUITE-START | Running 2 tests 07:58:20 INFO - TEST-START | dromaeo_css 07:58:20 INFO - operating with platform_type : mac_ 07:58:20 INFO - Initialising browser for dromaeo_css test... 07:58:20 INFO - TEST-INFO | started process 1640 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpVcOAsj/profile http://localhost:49243/getInfo.html) 07:58:22 INFO - PID 1640 | __metrics Screen width/height:1600/1200 07:58:22 INFO - PID 1640 | colorDepth:24 07:58:22 INFO - PID 1640 | Browser inner width/height: 1024/691 07:58:22 INFO - PID 1640 | __metrics 07:58:23 INFO - PID 1640 | 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" 07:58:23 INFO - PID 1640 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 07:58:23 INFO - TEST-INFO | 1640: exit 0 07:58:23 INFO - Browser initialized. 07:58:23 INFO - Running cycle 1/1 for dromaeo_css test... 07:58:23 INFO - TEST-INFO | started process 1642 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpVcOAsj/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/dromaeo/css.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 07:58:35 INFO - PID 1642 | RSS: Main: 241139712 07:58:35 INFO - PID 1642 | 08:01:41 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-dojo.html (next: http://localhost:49243/tests/dromaeo/cssquery-ext.html) 08:01:43 INFO - PID 1642 | RSS: Main: 458346496 08:01:43 INFO - PID 1642 | 08:04:46 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-ext.html (next: http://localhost:49243/tests/dromaeo/cssquery-jquery.html) 08:04:47 INFO - PID 1642 | RSS: Main: 362168320 08:04:47 INFO - PID 1642 | 08:07:49 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-jquery.html (next: http://localhost:49243/tests/dromaeo/cssquery-mootools.html) 08:07:49 INFO - PID 1642 | RSS: Main: 331382784 08:07:49 INFO - PID 1642 | 08:10:52 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-mootools.html (next: http://localhost:49243/tests/dromaeo/cssquery-prototype.html) 08:10:52 INFO - PID 1642 | RSS: Main: 322691072 08:10:52 INFO - PID 1642 | 08:13:56 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-prototype.html (next: http://localhost:49243/tests/dromaeo/cssquery-yui.html) 08:13:57 INFO - PID 1642 | RSS: Main: 329248768 08:13:57 INFO - PID 1642 | 08:16:59 INFO - PID 1642 | Cycle 1(1): loaded http://localhost:49243/tests/dromaeo/cssquery-yui.html (next: http://localhost:49243/tests/dromaeo/cssquery-dojo.html) 08:16:59 INFO - PID 1642 | RSS: Main: 371478528 08:16:59 INFO - PID 1642 | 08:16:59 INFO - PID 1642 | __start_tp_report 08:16:59 INFO - PID 1642 | _x_x_mozilla_page_load 08:16:59 INFO - PID 1642 | _x_x_mozilla_page_load_details 08:16:59 INFO - PID 1642 | |i|pagename|runs| 08:16:59 INFO - PID 1642 | |0;dojo.html;2912.3447224374513;3476.1657202271444;3532.735044871635;3545.734069944755;3555.679988801008;6131.774283661895;6207.5033997280225;6224.315325314217;6265.404786545277;6294.244690637119;5222.164453687411;6165;6234.968825155868;6248.406401391871;6279.686015699208;4341.696081274296;5391.110466772978;5429.56563474923;5449.073657478239;5494.313210848644;5480;5549.250851135105;5552.11166213406;5572.3870374258795;5573.247611572447;5361.571074314084;5408.891822163574;5418.997485465202;5439.673619582798;5489.972550137244;5483.670979741189;5486.231927530149;5489.204065410493;5490.3411590608985;5503.587230957654;5427.6472029317965;5447.918281225785;5455;5465.6447330923365;5466.890662186774;6210.223722034746;6229.2524897012645;6229.6573688447115;6230.314665386803;6240.843978900519;6440.0661904023655;6589.538732288742;6603.537752357337;6645.036469711865;6645.401913827779;6635.004749287597;6642.1033160523675;6729.899051514182;6774.898376524356;6815.42068924142;6276.96861515694;6282.968585157045;6292.087647291117;6297.307296197415;6299.0551417287315;6901.930980690229;6918.8962165567555;6921.377076063078;6928.861422771516;6945.617991010442;6373.107764912916;6405.935940640627;6417.839554011187;6432.421082102634;6524.869502609921;6671.766488172891;6680.031395447633;6690.13028306317;6710.798676039629;6728.932710672831;6545.869082618321;6573.276939536647;6585.670716464253;6603.108580341593;6616.4045235929;6512.055751915946;6630.502712296597;6635.071090047397;6640.435562977104;6643.236027856762;4291.399204111427;5207.244949482304;5212.869678258074;5213.426523082458;5226.372835259793;4656.837010704609;4661.696989695659;4696.553827386393;4749.976250118727;4791.760411979457;5113.360829896263;6203.31763506014;6234.906476402857;6328.6202827830475;6339.524535659844;6742.460603151736;6755.121834161528;6759.053732477457;6763.5265531413315;6773.085633439521;6323.241211054703;6340.556161068681;6348.428641422294;6352.936470635327;6354.205724284465;5738.5982981191755;5822.155787410802;5829.183914252008;5879.559033072536;5888.087346461305;5082.466341034138;6917.7232910684015;6986.16166060076;6996.475264355296;7001.719931202695;6737.831554210988;6772.627505487246;6781.254062053269;6786.117804685359;6791.796246112624;6948.930510694829;6979.092717946837;6980.755673551402;6994.300569942965;6998.335158159966;6414.326495717883;6450.161479007699;6575.112359831362;6645.1361323027695;6736.663166841737;5882.470577648032;6088.946570633196;6693.364130407798;6716.932830671826;6765.458763299022;6480.611163330215;6528.836779080561;6531.020346947996;6540.215174179129;6562.5406221564035;6265.185525881606;6481.967590162019;6494.6103233806125;6502.154719886574;6503.837404064936;6340.207474065742;6345.143405640364;6347.143135676809;6351.968240158954;6352.174217351715;6377.2984971654005;6490.091387205889;6537.05212744159;6557.278699343164;6575.309592492719;6310.6844657766005;6331.366863313632;6360.427561519486;6367.681615919279;6385.521085918482 08:16:59 INFO - PID 1642 | |1;ext.html;786.7836345005123;798.9680412783487;1097.917656175787;1117.793208256472;1117.8435019097328;27418.725812741868;36994;37287.62712372879;37431;37446.812765936134;39599.80200099003;39948;39991.200175996535;40072.599274007254;40094.39858402126;5972;8311.459755115913;8476.321894248476;8479.703210387637;8480.236778689916;5993.88012239755;8280.130586288444;8421.663133474654;8448.366372522054;8459.280961118313;8500.872486912702;8518.48889066658;8556.87164692527;8560.78598035051;8562.186592273723;5902.704864756745;8434.662613495484;8472.74581762548;8498.66286771143;8499;5950.9107363389585;8118.903947967008;8282.83434331316;8288.129746376604;8299.668013279523;36645.900622981084;36822.26355472903;36974;37022;37125.628743712485;3582.5521809773777;3627.147620309225;3628.1473853644375;3631.963680363189;3634;30781;30882.536761948588;30920.381592368027;30955.845220773976;30969.845150774327;3082.6300843898653;3151.6060492438446;3164.430402527544;3172.1752344390625;3172.809631422122;271732;276893;276907.6154619214;277199.6140019307;277898;39404.80297598494;39565.604343956766;49086.77283067952;49274.0145197094;49302.50697492979;41078.973025674;50598.24102638463;50663.49336506661;50717;51128.21051263188;13886.236257005961;13985.930070349583;14002.789958150635;14004.43982240699;14068.788968165485;11347.262427942158;11352.829707554394;11357.091432685365;11366.431678416046;11367.20429569922;12827.807582886264;12828.29444380568;12834.614961551168;12857.485700571873;12951.935240323737;5364.892702145935;5368.248445217672;5377.596680248997;5382.977234325465;5389.8113566025;932.0260327957301;932.7248461703814;1024.7386916336286;1066.8773091094467;1085.9402732849612;23786.88106559456;24827.5034499309;24843.751562484504;24884;24912.37719057038;1130.1636788776245;1132.8017596920506;1164.7495788405533;1166.7958107331353;1193.6061099837034;10167.305663999046;11309.264897781617;12553.087308011232;12603.495860165674;12725.109242352946;304873;305752;306314;306933;307303;53361;53435;53499.73250133725;53533;53555.73222133942;1523.2155439948435;1564.8748100151734;1581.4464937271862;1582.2958783341533;1582.374961890047;17689.46931592054;24183.879080605187;24288.906999185434;24338.391540211636;24360.63459048151;38798.80600596979;38847;38974.80512597419;38977.6102238974;38983.415248770725;266746;267313;267354;267430;267538.64922701824;29993.400131997674;30124.84937575298;34761.78333758306;34839.65160348364;35255.59305086864;42364.94087647834;42486;43788.124237514436;43907.560924390345;43964.78017609892;29375.559366609945;29465.85267073651;30275.697243028168;30290.394192116473;30624.92812751543;29300.706992929798;29649.555256670737;30079;30432.934847280238;30484.237894051937;30060.549091763205;34813.43339549676;36460.27079458449;36570.81714591516;36636.633633663325;29609.703902961555;29995.850020749756;30333.69666303397;30388.39223215479;30628;22286.554268914857;23665.881670591538;23770.76032680414;24000;24018.63972040386 08:16:59 INFO - PID 1642 | |2;jquery.html;390.46896221139247;411.5801882080276;416.768693375177;418.78432607207276;429.52108399134966;19871.13568508225;21046;21818;21982.34052978413;22027.66958495622;21564.245251416203;21812.345629631098;22100.557988840214;22174;22349.32952011438;5715.828525144252;6008.068749343859;6008.218931538894;6012.488938440238;6024.0662697282;5721.456461636138;5780.277465316835;5821.534277257831;5900.940990590082;5926.674032928187;5881.323647780518;5892.911606325909;5895.528357731371;5901.704914754267;5909.940900591004;5701.34434540027;5870.207521984542;5937.792177273818;5986.790462333841;6000.519958403317;5179.870503237449;5301.204819277101;5325.813596524142;5333.679979201261;5351.983123206578;27289.45421091587;27759.028434004715;27843;28158.859205704044;28233.294167645974;2183.5087105401317;2231.129859354853;2260.152442833937;2260.6722025306403;2262.468319944812;17579.912100439415;17690.646187076185;18116.728249076274;18351.54121146969;18389.448316550526;2053.876767393961;2140.3578926322043;2149.022194901316;2156.6225910465605;2162.416147640144;152830.47169528273;160073;160297;162007;170802.1459892705;11572;11695.532178712756;11951.521939122338;12068.396580171131;12242.510299587917;15943.24624291327;15950.361985520682;15983.440579579892;15992.840071599136;16009;8573.156771294078;8948.328875334377;8948.463092214488;9088.454692718326;9126.17864392208;8525.914740852511;8570.357223208284;8572.828543429096;8731.345149113842;8767.693130740394;7507.8498430031095;7627.733029343946;7677;7677.616119194018;7700.306972372513;1781.750554922312;2035.328341647253;2035.6793255688526;2057.249104077001;2219.178903805602;925.1396201532639;934.1125930366179;946.31392240625;947.4599478297305;954.2604481526733;20990.685139722915;21591.460213494473;21609.919504024736;21640.783592164193;21737.67393489099;869.4305230074311;974.7952929884661;990.2127808392202;994.8956658109493;1005.4118340770731;9141.588628511732;10455.059044686015;10493.632722854816;10986.340819550853;11034.834477482844;434827;478624;537236.3138184284;543102;545528;127456.36271818582;132363.80724795043;133253;133526.33236833755;135761;1128.6783266768932;1146.4611632532863;1165.9125565582615;1177.2289150606366;1177.5113327968968;17960.550986225448;18450.723239151153;18457.81542184561;18506.44480665582;18792.436226913214;56263;56295;57154.28537143892;57690;57809.13286300793;76451.61774191093;77604.61197693975;78705;79895.2010479911;81244.59377703074;8540.829183416421;8588.098249683693;8629.050804411385;8987.775305617412;9041.864372034557;13661.521846735317;13969.952253581225;14141;14298.642533936734;14379.856201437851;11751.059915206934;11824;12059.51761929513;12061.758764824479;12140.878591213976;9629.56666950003;10350.706161729784;10846.132309415385;11090.611828585961;11373.260738052;9910.603575857174;11848.58529951482;12164.817527736914;12234.327112008925;12251.448684809384;8560.828783424422;8600.526971016403;8757.562121894007;8804.119588041145;8818.955905220433;9532.475713835805;11640.359780211831;11960.58137965167;11963;12046.939765301116 08:16:59 INFO - PID 1642 | |3;mootools.html;1194.4684615346175;1394.9790753138702;1412.2162199979007;1430.6566424058228;1443.0836418874014;8455.450395724274;9601.567929443174;10018.24863135264;10032.347897386664;10037.247206459517;10676.35941843488;11314.660560183187;11315.717107072327;11319.886801131986;11357;2436.8537887726793;2450.7426720194344;2481.5781317176034;2490.1533478617357;2493.364192131004;2071.7099606055162;2314.241333883874;2478.1945867593013;2481.8759062046915;2482.7641374069435;2116.375669177596;2150.118451434912;2414.14297924237;2488.1664642344836;2499.4751102268547;2442.804575633945;2465.642481840132;2468.2348471973655;2471.530409222242;2475.7771800537857;2432.659427680126;2432.902683892642;2433.270018994295;2437.878106094688;2438.829281950264;11335.659930202024;11576.47905844239;11585.957263846294;11603.303801771921;11631.883681163165;6385.393387628168;6638;6644.734210631569;6651.301613330579;6682.632455214961;3943.507061617298;4152.211079894811;4229.767362795045;4314.331278651814;4326.697131200817;1233.876612338768;1239.535174309634;1281.724429247707;1288.4330894406526;1288.4395288049634;16663.33346666144;16691.582710432336;16692.916535417367;16705.415310464075;16709.415170468976;5055.938252966845;5708.457696518824;5876.236089308448;5921.3190483094995;6035.547333949883;13623.978201634916;13631.727365452834;13638.454461821417;13654.658633534242;13656.863431365558;6716.1604799400075;6716.630585317855;6721.361470660279;6726.091977583062;6756.797296081126;4791.784369703302;6015.947209238453;6190.164327815687;6227;6227.408396202353;4400.75795831226;4484.439445069366;4514.548545145459;4573.702709323883;4677.929831052537;1398.4685819388772;1423.3737155651481;1426.7289215049107;1446.197360464952;1449.355037008521;668.9063232083547;719.9136103667594;787.9015123109612;805.9194080591894;809.805646644801;6412.61524308543;6439.7424103035355;6580.5722628029025;6796.626185559743;6885.345892140239;910.8906931168302;914.6570036236411;922.0272612393854;923.9122283383068;954.236610711428;3474.5483087198504;4202.873913782591;4261.552536983572;4262.680298977589;4401.559844015573;14240.786388204186;14943.77584336214;14970.625734356729;14975.550733478012;15167.317470713844;14405.92797036008;14863.851361486462;14939.02896311758;14951.775723364159;14968.775468367983;8410.957945210235;8653.437526560754;8658.740237792876;8667.479951203075;8673.956630216808;6556.18047744032;6864.622445765531;7036.648167591702;7056.470764692771;7088.964555177397;11003.284786488852;12937.611871643865;13700.246486442942;13700.65748356299;13714.971377146954;13433.596992090253;13937.58187254384;13944.58166255014;14086.084404513675;14292.571222863331;9172.678956236767;9457.716268511957;9463.337566370563;9472.100150485692;9473.242140628596;10492.317999330018;10497.47512624381;10526.368417894952;10614.681559553226;10637.680869573926;8907.465552066897;8954.507502087448;9029.142231487998;9053.864192037256;9112.681056163003;8712.39013269065;8838.469691818511;8845;8871.64513419456;8927.821443571222;7984.20157984197;8102.83794324122;8107.675692972215;8117.431779775359;8122.390820688353;5819.388964158702;5848.53211743051;5984.850378740566;6067.12026756109;6091.208142941389;5465.344158700981;5678.659280443187;6056.57603967718;6100.206973093647;6267.655278959701 08:16:59 INFO - PID 1642 | |4;prototype.html;391.1453474158963;395.8772780438066;398.1221406798009;401.927653022456;405.6511400195829;4280.700350975433;5145.511176438237;5663.235463212465;5868.00243958527;5878.650428110415;5306.3632364116265;5791.913121303184;5814.680192589406;5847.736851841667;5855.47300742933;4552.4764652065105;4570.771461426932;4586.894729217349;4588.701734387271;4622.768861556917;3966.4050392441222;4591.334256532801;4595.8969847236585;4600.056988317387;4617.2381557043045;4114.259433302004;4393.912121757563;4545.159145558082;4579.084183163381;4597.4483062032605;3449.8792542261153;4010.5588385277597;4241.300185469394;4469.843555475575;4556.658250631182;3526;3552.378333791576;3951.46655201547;4070.267351876661;4112.691548133872;5187.844364669066;5581.6930068846195;5588.608797384185;5679.375268720438;5913.142594323799;5378.327709036371;5423.376311724162;5431.83704488866;5443.727813609304;5494.450554944514;5311;5459.69971651559;6180.536459765491;6335.746570137189;6342.968285158591;4250.298700714378;4270.658347332206;4436.245838207513;4601.884952876171;4667.789949452249;4932.558383600069;5140.663427508837;5829.387914269026;6548.579708696659;6612.239592446882;4151.730137541111;4385.495667998221;4475.216837053503;4563.133004729091;4568.543145685405;4278.465191851019;4704.7412392318065;4724.2205036169335;4857.441394239637;4866.78099485524;4227.309076369415;4437.911241775147;4929.827456039022;5208.947910520922;5351.652142610717;6195.783147589813;6292.46514046302;6314.179156709598;6331.778387756406;6368.936310636927;1546.9767953480707;1623.3993422433539;1624.1554391716477;1644.9506514804575;1651.4385109062737;1108.5842808946645;1152.6023521884936;1154.4862536171322;1168.7968179980796;1169.9590514332128;5908.881822363614;5915.556333274935;5929.110633405024;5940.70296485174;5952.880942381128;5183.455737147545;6501.577397469149;6505.4795616350575;6515.609063456208;6607.339266073354;5649.435056494318;5826.621269617462;5859.677717725481;5891.499222566044;5906.2912450505355;3248.1067706380463;3352.6814952579953;3411;3413.6245013048547;3416.777909435879;5614.29821272341;6452.709628066748;6698.961660942562;6717.56335838169;6724.966375168093;6525.575837570543;6633.303503132198;6637.435817955431;6639.4024537790865;6677.899831502531;5414.269073675082;6415.518836087312;6668.166479190101;6736.427403670743;6743;4852.417709874838;5809.767609295581;6153.446189842935;6220.906686399798;6464.254651244231;5597.720113994365;5675.432456754292;6096.725647345791;6173.259208894961;6340.365963403623;5571.08077167279;6636.71033493444;6668.6665666717445;6706.66466676674;6720.32796720324;4544.091181763594;4582.358469814162;4731.526847315241;4733.83431579893;4790.329353890528;6353.426862120848;6399.584027038228;6445.12990746262;6488.837779055561;6495.577787443801;5301.4168441472175;6191.380861913773;6224.221972253468;6235.563510554399;6249.9062514063235;5083.38999320084;5354.651947623392;5993.340732519507;6019;6299.748010079546;5415.48552887475;5755.61865152352;6096.591846220629;6109.877802443837;6165.321814600301;4772.7136371817805;6242.692542145905;6261.342559031236;6283.874322513616;6310.211223597051;5292.3649162099255;5304.708241046779;5671.376148623565;6073.817785466443;6106.267247930099 08:16:59 INFO - PID 1642 | |5;yui.html;830.0744669693294;853.4154104438456;854.679495189304;855.4653341661461;872.0668884293808;14192.716145677094;15668.686626267468;16262.75605865913;16567.100757367472;16597.41909033184;17740.556486087822;17756.289748410047;18138.3651572195;18217;18298.817011829877;805.629410471184;923.5751554285036;956.6699488676395;959.4147569982305;959.6737109382808;997.8104160209573;997.9351342162772;998.2014388489216;1000.304788172217;1005.5977608956439;1002.0680766886792;1002.8395456726888;1003.9548220330103;1004.1464754958264;1041.666666666667;1001.9549120289604;1002.0680766886792;1003.4631472162395;1003.5534187286661;1042.5412818359935;731.5756861020595;733.2484203691206;733.2667332667332;743.8400743840047;769.1769806307253;13071;13497.190168589916;16989.660206795794;17145.914270428693;17185.96884186953;14622.926885365612;17014.78807754996;17207.88148770326;17439.564010899703;17642.735358969625;14010.439582416691;14081.08472949255;14093.224872632001;14162.575122746232;14331.355089021019;3483.9825800871085;3507.421275489541;3507.719382449398;3514.578250609943;3516.613172551017;92408.53795731046;135625;136269;138636.30681846628;138858;10377.584896604052;10787.78424431507;11139.665810025712;11537.307761534335;13943;25285;25600.871995639904;25818;26164.476710466064;26358.604620930702;7814.765557033298;7980.840383192303;8063.798405039921;8090.959545202354;8119.188081191834;3940.389239667856;3998.460207871958;4001.6198461146146;4001.799910004488;4003.159336539359;4331.328644060176;4377.4965878923695;4380.342948557678;4401.801918913657;4443.422355093817;925.7546750111226;946.0161432110528;947.9810403791886;951.9381240219363;953.537534295866;649.7855707616475;650.1483057195089;650.9967450162814;660.7257987934953;685.5475386245055;10370.585176593002;11243.212975091828;11323.094152467782;11913.285202887855;11952.04383649306;640.2029473305764;656.6486929492698;663.5852592129919;671.7145213284334;689.762032098925;4839.854804355875;5449.6730196188355;5487.451254874561;5526.972365138148;5616.943830561642;86394;103656.96343036473;105048;107119;107270.92729072766;93621.5318923401;95358.52320738352;96434;96671;97619;81355;81997;82852;83118.58440707879;84141.15858841334;9531.809363812547;11246.831297530707;11804.409779511161;11932.105092117952;12284.01727861751;39387.42450301956;39397;39813.60186398215;39994.800025999684;40090.39864402095;43310.83445827759;47576.762116189195;50756.23865642092;51035.48964510307;51920;16107.516774496784;16465.600423964097;16738.163091845116;16787;16793.32826686919;18047.318092710382;18191.636167276316;18357.3574924877;18490.075496225403;18697;16540.66918661644;17001.829981700026;17131.571710707332;17169.055701936515;17356.47930562085;16608.58478537998;16708.248128833988;16728.498145055666;17038.659226815642;17061;16203.918980405022;16564.585885352964;16619.91690041542;16638.833611664213;16765.66468670644;11575.247608905394;11625.418729063682;12017.278963262232;12131.939340303243;12455.439505222106;12546;12770.744585108432;12867.742645146858;12961.416736246703;12985.930585597385 08:16:59 INFO - PID 1642 | __end_tp_report 08:16:59 INFO - PID 1642 | __start_cc_report 08:16:59 INFO - PID 1642 | _x_x_mozilla_cycle_collect,2568 08:16:59 INFO - PID 1642 | __end_cc_report 08:16:59 INFO - PID 1642 | __startTimestamp1493997419677__endTimestamp 08:16:59 INFO - PID 1642 | 08:16:59 INFO - PID 1642 | ------- Summary: start ------- 08:16:59 INFO - PID 1642 | Number of tests: 6 08:16:59 INFO - PID 1642 | 08:16:59 INFO - PID 1642 | [#0] dojo.html Cycles:165 Average:6124.57 Median:6351.97 stddev:770.82 (12.1%) stddev-sans-first:730.84 08:16:59 INFO - PID 1642 | Values: 2912.3 3476.2 3532.7 3545.7 3555.7 6131.8 6207.5 6224.3 6265.4 6294.2 5222.2 6165.0 6235.0 6248.4 6279.7 4341.7 5391.1 5429.6 5449.1 5494.3 5480.0 5549.3 5552.1 5572.4 5573.2 5361.6 5408.9 5419.0 5439.7 5490.0 5483.7 5486.2 5489.2 5490.3 5503.6 5427.6 5447.9 5455.0 5465.6 5466.9 6210.2 6229.3 6229.7 6230.3 6240.8 6440.1 6589.5 6603.5 6645.0 6645.4 6635.0 6642.1 6729.9 6774.9 6815.4 6277.0 6283.0 6292.1 6297.3 6299.1 6901.9 6918.9 6921.4 6928.9 6945.6 6373.1 6405.9 6417.8 6432.4 6524.9 6671.8 6680.0 6690.1 6710.8 6728.9 6545.9 6573.3 6585.7 6603.1 6616.4 6512.1 6630.5 6635.1 6640.4 6643.2 4291.4 5207.2 5212.9 5213.4 5226.4 4656.8 4661.7 4696.6 4750.0 4791.8 5113.4 6203.3 6234.9 6328.6 6339.5 6742.5 6755.1 6759.1 6763.5 6773.1 6323.2 6340.6 6348.4 6352.9 6354.2 5738.6 5822.2 5829.2 5879.6 5888.1 5082.5 6917.7 6986.2 6996.5 7001.7 6737.8 6772.6 6781.3 6786.1 6791.8 6948.9 6979.1 6980.8 6994.3 6998.3 6414.3 6450.2 6575.1 6645.1 6736.7 5882.5 6088.9 6693.4 6716.9 6765.5 6480.6 6528.8 6531.0 6540.2 6562.5 6265.2 6482.0 6494.6 6502.2 6503.8 6340.2 6345.1 6347.1 6352.0 6352.2 6377.3 6490.1 6537.1 6557.3 6575.3 6310.7 6331.4 6360.4 6367.7 6385.5 08:16:59 INFO - PID 1642 | 08:16:59 INFO - PID 1642 | [#1] ext.html Cycles:180 Average:43303.66 Median:17060.73 stddev:74295.36 (435.5%) stddev-sans-first:74435.20 08:16:59 INFO - PID 1642 | Values: 786.8 799.0 1097.9 1117.8 1117.8 27418.7 36994.0 37287.6 37431.0 37446.8 39599.8 39948.0 39991.2 40072.6 40094.4 5972.0 8311.5 8476.3 8479.7 8480.2 5993.9 8280.1 8421.7 8448.4 8459.3 8500.9 8518.5 8556.9 8560.8 8562.2 5902.7 8434.7 8472.7 8498.7 8499.0 5950.9 8118.9 8282.8 8288.1 8299.7 36645.9 36822.3 36974.0 37022.0 37125.6 3582.6 3627.1 3628.1 3632.0 3634.0 30781.0 30882.5 30920.4 30955.8 30969.8 3082.6 3151.6 3164.4 3172.2 3172.8 271732.0 276893.0 276907.6 277199.6 277898.0 39404.8 39565.6 49086.8 49274.0 49302.5 41079.0 50598.2 50663.5 50717.0 51128.2 13886.2 13985.9 14002.8 14004.4 14068.8 11347.3 11352.8 11357.1 11366.4 11367.2 12827.8 12828.3 12834.6 12857.5 12951.9 5364.9 5368.2 5377.6 5383.0 5389.8 932.0 932.7 1024.7 1066.9 1085.9 23786.9 24827.5 24843.8 24884.0 24912.4 1130.2 1132.8 1164.7 1166.8 1193.6 10167.3 11309.3 12553.1 12603.5 12725.1 304873.0 305752.0 306314.0 306933.0 307303.0 53361.0 53435.0 53499.7 53533.0 53555.7 1523.2 1564.9 1581.4 1582.3 1582.4 17689.5 24183.9 24288.9 24338.4 24360.6 38798.8 38847.0 38974.8 38977.6 38983.4 266746.0 267313.0 267354.0 267430.0 267538.6 29993.4 30124.8 34761.8 34839.7 35255.6 42364.9 42486.0 43788.1 43907.6 43964.8 29375.6 29465.9 30275.7 30290.4 30624.9 29300.7 29649.6 30079.0 30432.9 30484.2 30060.5 34813.4 36460.3 36570.8 36636.6 29609.7 29995.9 30333.7 30388.4 30628.0 22286.6 23665.9 23770.8 24000.0 24018.6 08:16:59 INFO - PID 1642 | 08:16:59 INFO - PID 1642 | [#2] jquery.html Cycles:180 Average:34613.92 Median:2261.57 stddev:87548.70 (3871.1%) stddev-sans-first:87756.59 08:16:59 INFO - PID 1642 | Values: 390.5 411.6 416.8 418.8 429.5 19871.1 21046.0 21818.0 21982.3 22027.7 21564.2 21812.3 22100.6 22174.0 22349.3 5715.8 6008.1 6008.2 6012.5 6024.1 5721.5 5780.3 5821.5 5900.9 5926.7 5881.3 5892.9 5895.5 5901.7 5909.9 5701.3 5870.2 5937.8 5986.8 6000.5 5179.9 5301.2 5325.8 5333.7 5352.0 27289.5 27759.0 27843.0 28158.9 28233.3 2183.5 2231.1 2260.2 2260.7 2262.5 17579.9 17690.6 18116.7 18351.5 18389.4 2053.9 2140.4 2149.0 2156.6 2162.4 152830.5 160073.0 160297.0 162007.0 170802.1 11572.0 11695.5 11951.5 12068.4 12242.5 15943.2 15950.4 15983.4 15992.8 16009.0 8573.2 8948.3 8948.5 9088.5 9126.2 8525.9 8570.4 8572.8 8731.3 8767.7 7507.8 7627.7 7677.0 7677.6 7700.3 1781.8 2035.3 2035.7 2057.2 2219.2 925.1 934.1 946.3 947.5 954.3 20990.7 21591.5 21609.9 21640.8 21737.7 869.4 974.8 990.2 994.9 1005.4 9141.6 10455.1 10493.6 10986.3 11034.8 434827.0 478624.0 537236.3 543102.0 545528.0 127456.4 132363.8 133253.0 133526.3 135761.0 1128.7 1146.5 1165.9 1177.2 1177.5 17960.6 18450.7 18457.8 18506.4 18792.4 56263.0 56295.0 57154.3 57690.0 57809.1 76451.6 77604.6 78705.0 79895.2 81244.6 8540.8 8588.1 8629.1 8987.8 9041.9 13661.5 13970.0 14141.0 14298.6 14379.9 11751.1 11824.0 12059.5 12061.8 12140.9 9629.6 10350.7 10846.1 11090.6 11373.3 9910.6 11848.6 12164.8 12234.3 12251.4 8560.8 8600.5 8757.6 8804.1 8819.0 9532.5 11640.4 11960.6 11963.0 12046.9 08:16:59 INFO - PID 1642 | 08:16:59 INFO - PID 1642 | [#3] mootools.html Cycles:180 Average:7079.97 Median:4177.54 stddev:4506.22 (107.9%) stddev-sans-first:4497.15 08:16:59 INFO - PID 1642 | Values: 1194.5 1395.0 1412.2 1430.7 1443.1 8455.5 9601.6 10018.2 10032.3 10037.2 10676.4 11314.7 11315.7 11319.9 11357.0 2436.9 2450.7 2481.6 2490.2 2493.4 2071.7 2314.2 2478.2 2481.9 2482.8 2116.4 2150.1 2414.1 2488.2 2499.5 2442.8 2465.6 2468.2 2471.5 2475.8 2432.7 2432.9 2433.3 2437.9 2438.8 11335.7 11576.5 11586.0 11603.3 11631.9 6385.4 6638.0 6644.7 6651.3 6682.6 3943.5 4152.2 4229.8 4314.3 4326.7 1233.9 1239.5 1281.7 1288.4 1288.4 16663.3 16691.6 16692.9 16705.4 16709.4 5055.9 5708.5 5876.2 5921.3 6035.5 13624.0 13631.7 13638.5 13654.7 13656.9 6716.2 6716.6 6721.4 6726.1 6756.8 4791.8 6015.9 6190.2 6227.0 6227.4 4400.8 4484.4 4514.5 4573.7 4677.9 1398.5 1423.4 1426.7 1446.2 1449.4 668.9 719.9 787.9 805.9 809.8 6412.6 6439.7 6580.6 6796.6 6885.3 910.9 914.7 922.0 923.9 954.2 3474.5 4202.9 4261.6 4262.7 4401.6 14240.8 14943.8 14970.6 14975.6 15167.3 14405.9 14863.9 14939.0 14951.8 14968.8 8411.0 8653.4 8658.7 8667.5 8674.0 6556.2 6864.6 7036.6 7056.5 7089.0 11003.3 12937.6 13700.2 13700.7 13715.0 13433.6 13937.6 13944.6 14086.1 14292.6 9172.7 9457.7 9463.3 9472.1 9473.2 10492.3 10497.5 10526.4 10614.7 10637.7 8907.5 8954.5 9029.1 9053.9 9112.7 8712.4 8838.5 8845.0 8871.6 8927.8 7984.2 8102.8 8107.7 8117.4 8122.4 5819.4 5848.5 5984.9 6067.1 6091.2 5465.3 5678.7 6056.6 6100.2 6267.7 08:16:59 INFO - PID 1642 | 08:16:59 INFO - PID 1642 | [#4] prototype.html Cycles:180 Average:5079.63 Median:5451.71 stddev:1510.13 (27.7%) stddev-sans-first:1472.79 08:16:59 INFO - PID 1642 | Values: 391.1 395.9 398.1 401.9 405.7 4280.7 5145.5 5663.2 5868.0 5878.7 5306.4 5791.9 5814.7 5847.7 5855.5 4552.5 4570.8 4586.9 4588.7 4622.8 3966.4 4591.3 4595.9 4600.1 4617.2 4114.3 4393.9 4545.2 4579.1 4597.4 3449.9 4010.6 4241.3 4469.8 4556.7 3526.0 3552.4 3951.5 4070.3 4112.7 5187.8 5581.7 5588.6 5679.4 5913.1 5378.3 5423.4 5431.8 5443.7 5494.5 5311.0 5459.7 6180.5 6335.7 6343.0 4250.3 4270.7 4436.2 4601.9 4667.8 4932.6 5140.7 5829.4 6548.6 6612.2 4151.7 4385.5 4475.2 4563.1 4568.5 4278.5 4704.7 4724.2 4857.4 4866.8 4227.3 4437.9 4929.8 5208.9 5351.7 6195.8 6292.5 6314.2 6331.8 6368.9 1547.0 1623.4 1624.2 1645.0 1651.4 1108.6 1152.6 1154.5 1168.8 1170.0 5908.9 5915.6 5929.1 5940.7 5952.9 5183.5 6501.6 6505.5 6515.6 6607.3 5649.4 5826.6 5859.7 5891.5 5906.3 3248.1 3352.7 3411.0 3413.6 3416.8 5614.3 6452.7 6699.0 6717.6 6725.0 6525.6 6633.3 6637.4 6639.4 6677.9 5414.3 6415.5 6668.2 6736.4 6743.0 4852.4 5809.8 6153.4 6220.9 6464.3 5597.7 5675.4 6096.7 6173.3 6340.4 5571.1 6636.7 6668.7 6706.7 6720.3 4544.1 4582.4 4731.5 4733.8 4790.3 6353.4 6399.6 6445.1 6488.8 6495.6 5301.4 6191.4 6224.2 6235.6 6249.9 5083.4 5354.7 5993.3 6019.0 6299.7 5415.5 5755.6 6096.6 6109.9 6165.3 4772.7 6242.7 6261.3 6283.9 6310.2 5292.4 5304.7 5671.4 6073.8 6106.3 08:16:59 INFO - PID 1642 | 08:16:59 INFO - PID 1642 | [#5] yui.html Cycles:180 Average:21702.61 Median:18328.09 stddev:31089.12 (169.6%) stddev-sans-first:31136.83 08:16:59 INFO - PID 1642 | Values: 830.1 853.4 854.7 855.5 872.1 14192.7 15668.7 16262.8 16567.1 16597.4 17740.6 17756.3 18138.4 18217.0 18298.8 805.6 923.6 956.7 959.4 959.7 997.8 997.9 998.2 1000.3 1005.6 1002.1 1002.8 1004.0 1004.1 1041.7 1002.0 1002.1 1003.5 1003.6 1042.5 731.6 733.2 733.3 743.8 769.2 13071.0 13497.2 16989.7 17145.9 17186.0 14622.9 17014.8 17207.9 17439.6 17642.7 14010.4 14081.1 14093.2 14162.6 14331.4 3484.0 3507.4 3507.7 3514.6 3516.6 92408.5 135625.0 136269.0 138636.3 138858.0 10377.6 10787.8 11139.7 11537.3 13943.0 25285.0 25600.9 25818.0 26164.5 26358.6 7814.8 7980.8 8063.8 8091.0 8119.2 3940.4 3998.5 4001.6 4001.8 4003.2 4331.3 4377.5 4380.3 4401.8 4443.4 925.8 946.0 948.0 951.9 953.5 649.8 650.1 651.0 660.7 685.5 10370.6 11243.2 11323.1 11913.3 11952.0 640.2 656.6 663.6 671.7 689.8 4839.9 5449.7 5487.5 5527.0 5616.9 86394.0 103657.0 105048.0 107119.0 107270.9 93621.5 95358.5 96434.0 96671.0 97619.0 81355.0 81997.0 82852.0 83118.6 84141.2 9531.8 11246.8 11804.4 11932.1 12284.0 39387.4 39397.0 39813.6 39994.8 40090.4 43310.8 47576.8 50756.2 51035.5 51920.0 16107.5 16465.6 16738.2 16787.0 16793.3 18047.3 18191.6 18357.4 18490.1 18697.0 16540.7 17001.8 17131.6 17169.1 17356.5 16608.6 16708.2 16728.5 17038.7 17061.0 16203.9 16564.6 16619.9 16638.8 16765.7 11575.2 11625.4 12017.3 12131.9 12455.4 12546.0 12770.7 12867.7 12961.4 12985.9 08:16:59 INFO - PID 1642 | -------- Summary: end -------- 08:16:59 INFO - PID 1642 | 08:17:00 INFO - TEST-INFO | 1642: exit 0 08:17:00 INFO - TEST-OK | dromaeo_css | took 1120082ms 08:17:00 INFO - TEST-START | kraken 08:17:00 INFO - operating with platform_type : mac_ 08:17:00 INFO - Initialising browser for kraken test... 08:17:00 INFO - TEST-INFO | started process 1654 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpthD1PO/profile http://localhost:49243/getInfo.html) 08:17:02 INFO - PID 1654 | __metrics Screen width/height:1600/1200 08:17:02 INFO - PID 1654 | colorDepth:24 08:17:02 INFO - PID 1654 | Browser inner width/height: 1024/691 08:17:02 INFO - PID 1654 | __metrics 08:17:02 INFO - PID 1654 | JavaScript error: resource://gre/modules/AsyncShutdown.jsm, line 673: Error: Phase "quit-application-granted" is finished, it is too late to register completion condition "SessionStore: flushing all windows" 08:17:02 INFO - PID 1654 | JavaScript error: resource:///modules/BrowserUsageTelemetry.jsm, line 334: NS_ERROR_FAILURE: Component returned failure code: 0x80004005 (NS_ERROR_FAILURE) [nsIObserverService.removeObserver] 08:17:03 INFO - TEST-INFO | 1654: exit 0 08:17:03 INFO - Browser initialized. 08:17:03 INFO - Running cycle 1/1 for kraken test... 08:17:03 INFO - TEST-INFO | started process 1655 (/builds/slave/test/build/application/Nightly.app/Contents/MacOS/firefox -foreground -profile /var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/T/tmpthD1PO/profile -tp file:/builds/slave/test/build/tests/talos/talos/tests/kraken/kraken.manifest.develop -tpchrome -tpnoisy -tpcycles 1 -tppagecycles 1) 08:17:16 INFO - PID 1655 | RSS: Main: 239685632 08:17:16 INFO - PID 1655 | 08:17:18 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=ai-astar (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection) 08:17:19 INFO - PID 1655 | RSS: Main: 307945472 08:17:19 INFO - PID 1655 | 08:17:22 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-beat-detection (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-dft) 08:17:22 INFO - PID 1655 | RSS: Main: 291287040 08:17:22 INFO - PID 1655 | 08:17:26 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-dft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-fft) 08:17:26 INFO - PID 1655 | RSS: Main: 382722048 08:17:26 INFO - PID 1655 | 08:17:28 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-fft (next: http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator) 08:17:29 INFO - PID 1655 | RSS: Main: 286601216 08:17:29 INFO - PID 1655 | 08:17:31 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=audio-oscillator (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur) 08:17:31 INFO - PID 1655 | RSS: Main: 289439744 08:17:31 INFO - PID 1655 | 08:17:34 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-gaussian-blur (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom) 08:17:35 INFO - PID 1655 | RSS: Main: 354172928 08:17:35 INFO - PID 1655 | 08:17:38 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-darkroom (next: http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate) 08:17:38 INFO - PID 1655 | RSS: Main: 370073600 08:17:38 INFO - PID 1655 | 08:17:41 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=imaging-desaturate (next: http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial) 08:17:42 INFO - PID 1655 | RSS: Main: 380170240 08:17:42 INFO - PID 1655 | 08:17:43 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-parse-financial (next: http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox) 08:17:44 INFO - PID 1655 | RSS: Main: 327507968 08:17:44 INFO - PID 1655 | 08:17:46 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=json-stringify-tinderbox (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes) 08:17:46 INFO - PID 1655 | RSS: Main: 329908224 08:17:46 INFO - PID 1655 | 08:17:49 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-aes (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm) 08:17:49 INFO - PID 1655 | RSS: Main: 331948032 08:17:49 INFO - PID 1655 | 08:17:52 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-ccm (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2) 08:17:53 INFO - PID 1655 | RSS: Main: 351178752 08:17:53 INFO - PID 1655 | 08:17:56 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-pbkdf2 (next: http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative) 08:17:56 INFO - PID 1655 | RSS: Main: 343891968 08:17:56 INFO - PID 1655 | 08:17:58 INFO - PID 1655 | Cycle 1(1): loaded http://localhost:49243/tests/kraken/driver.html?testName=stanford-crypto-sha256-iterative (next: http://localhost:49243/tests/kraken/driver.html?testName=ai-astar) 08:17:58 INFO - PID 1655 | RSS: Main: 386916352 08:17:58 INFO - PID 1655 | 08:17:58 INFO - PID 1655 | __start_tp_report 08:17:58 INFO - PID 1655 | _x_x_mozilla_page_load 08:17:58 INFO - PID 1655 | _x_x_mozilla_page_load_details 08:17:58 INFO - PID 1655 | |i|pagename|runs| 08:17:58 INFO - PID 1655 | |0;ai-astar;111;111;111;111;111;112;111;111;111;111 08:17:58 INFO - PID 1655 | |1;audio-beat-detection;138;109;109;150;110;109;106;108;137;107 08:17:58 INFO - PID 1655 | |2;audio-dft;186;186;184;186;187;184;183;188;185;181 08:17:58 INFO - PID 1655 | |3;audio-fft;81;61;61;89;61;60;59;62;81;57 08:17:58 INFO - PID 1655 | |4;audio-oscillator;90;70;85;68;69;67;88;68;67;90 08:17:58 INFO - PID 1655 | |5;imaging-gaussian-blur;90;90;90;90;90;89;90;90;90;91 08:17:58 INFO - PID 1655 | |6;imaging-darkroom;97;95;96;98;96;96;97;97;97;95 08:17:58 INFO - PID 1655 | |7;imaging-desaturate;85;84;87;87;86;85;85;83;86;86 08:17:58 INFO - PID 1655 | |8;json-parse-financial;50;48;47;47;49;50;48;48;49;48 08:17:58 INFO - PID 1655 | |9;json-stringify-tinderbox;54;52;60;68;62;60;57;57;57;55 08:17:58 INFO - PID 1655 | |10;stanford-crypto-aes;83;78;82;75;81;83;80;83;81;81 08:17:58 INFO - PID 1655 | |11;stanford-crypto-ccm;138;133;137;135;135;142;119;136;195;168 08:17:58 INFO - PID 1655 | |12;stanford-crypto-pbkdf2;168;229;187;183;182;182;184;174;179;183 08:17:58 INFO - PID 1655 | |13;stanford-crypto-sha256-iterative;67;67;66;67;68;69;66;67;68;66 08:17:58 INFO - PID 1655 | __end_tp_report 08:17:58 INFO - PID 1655 | __start_cc_report 08:17:58 INFO - PID 1655 | _x_x_mozilla_cycle_collect,2175 08:17:58 INFO - PID 1655 | __end_cc_report 08:17:58 INFO - PID 1655 | __startTimestamp1493997478946__endTimestamp 08:17:58 INFO - PID 1655 | 08:17:58 INFO - PID 1655 | ------- Summary: start ------- 08:17:58 INFO - PID 1655 | Number of tests: 14 08:17:58 INFO - PID 1655 | 08:17:58 INFO - PID 1655 | [#0] ai-astar Cycles:10 Average:111.10 Median:111.00 stddev:0.32 (0.3%) stddev-sans-first:0.33 08:17:58 INFO - PID 1655 | Values: 111.0 111.0 111.0 111.0 111.0 112.0 111.0 111.0 111.0 111.0 08:17:58 INFO - PID 1655 | 08:17:58 INFO - PID 1655 | [#1] audio-beat-detection Cycles:10 Average:118.30 Median:109.50 stddev:16.52 (15.1%) stddev-sans-first:15.91 08:17:58 INFO - PID 1655 | Values: 138.0 109.0 109.0 150.0 110.0 109.0 106.0 108.0 137.0 107.0 08:17:58 INFO - PID 1655 | 08:17:58 INFO - PID 1655 | [#2] audio-dft Cycles:10 Average:185.00 Median:186.00 stddev:2.05 (1.1%) stddev-sans-first:2.15 08:17:58 INFO - PID 1655 | Values: 186.0 186.0 184.0 186.0 187.0 184.0 183.0 188.0 185.0 181.0 08:17:58 INFO - PID 1655 | 08:17:58 INFO - PID 1655 | [#3] audio-fft Cycles:10 Average:67.20 Median:61.50 stddev:11.65 (18.9%) stddev-sans-first:11.24 08:17:58 INFO - PID 1655 | Values: 81.0 61.0 61.0 89.0 61.0 60.0 59.0 62.0 81.0 57.0 08:17:58 INFO - PID 1655 | 08:17:58 INFO - PID 1655 | [#4] audio-oscillator Cycles:10 Average:76.20 Median:77.50 stddev:10.50 (13.5%) stddev-sans-first:9.87 08:17:58 INFO - PID 1655 | Values: 90.0 70.0 85.0 68.0 69.0 67.0 88.0 68.0 67.0 90.0 08:17:58 INFO - PID 1655 | 08:17:58 INFO - PID 1655 | [#5] imaging-gaussian-blur Cycles:10 Average:90.00 Median:90.00 stddev:0.47 (0.5%) stddev-sans-first:0.50 08:17:58 INFO - PID 1655 | Values: 90.0 90.0 90.0 90.0 90.0 89.0 90.0 90.0 90.0 91.0 08:17:58 INFO - PID 1655 | 08:17:58 INFO - PID 1655 | [#6] imaging-darkroom Cycles:10 Average:96.40 Median:97.00 stddev:0.97 (1.0%) stddev-sans-first:1.00 08:17:58 INFO - PID 1655 | Values: 97.0 95.0 96.0 98.0 96.0 96.0 97.0 97.0 97.0 95.0 08:17:58 INFO - PID 1655 | 08:17:58 INFO - PID 1655 | [#7] imaging-desaturate Cycles:10 Average:85.40 Median:86.00 stddev:1.26 (1.5%) stddev-sans-first:1.33 08:17:58 INFO - PID 1655 | Values: 85.0 84.0 87.0 87.0 86.0 85.0 85.0 83.0 86.0 86.0 08:17:58 INFO - PID 1655 | 08:17:58 INFO - PID 1655 | [#8] json-parse-financial Cycles:10 Average:48.40 Median:48.50 stddev:1.07 (2.2%) stddev-sans-first:0.97 08:17:58 INFO - PID 1655 | Values: 50.0 48.0 47.0 47.0 49.0 50.0 48.0 48.0 49.0 48.0 08:17:58 INFO - PID 1655 | 08:17:58 INFO - PID 1655 | [#9] json-stringify-tinderbox Cycles:10 Average:58.20 Median:58.50 stddev:4.57 (7.8%) stddev-sans-first:4.58 08:17:58 INFO - PID 1655 | Values: 54.0 52.0 60.0 68.0 62.0 60.0 57.0 57.0 57.0 55.0 08:17:58 INFO - PID 1655 | 08:17:58 INFO - PID 1655 | [#10] stanford-crypto-aes Cycles:10 Average:80.70 Median:81.50 stddev:2.54 (3.1%) stddev-sans-first:2.55 08:17:58 INFO - PID 1655 | Values: 83.0 78.0 82.0 75.0 81.0 83.0 80.0 83.0 81.0 81.0 08:17:58 INFO - PID 1655 | 08:17:58 INFO - PID 1655 | [#11] stanford-crypto-ccm Cycles:10 Average:143.80 Median:137.50 stddev:21.70 (15.8%) stddev-sans-first:22.91 08:17:58 INFO - PID 1655 | Values: 138.0 133.0 137.0 135.0 135.0 142.0 119.0 136.0 195.0 168.0 08:17:58 INFO - PID 1655 | 08:17:58 INFO - PID 1655 | [#12] stanford-crypto-pbkdf2 Cycles:10 Average:185.10 Median:183.00 stddev:16.37 (8.9%) stddev-sans-first:16.16 08:17:58 INFO - PID 1655 | Values: 168.0 229.0 187.0 183.0 182.0 182.0 184.0 174.0 179.0 183.0 08:17:58 INFO - PID 1655 | 08:17:58 INFO - PID 1655 | [#13] stanford-crypto-sha256-iterative Cycles:10 Average:67.10 Median:67.00 stddev:0.99 (1.5%) stddev-sans-first:1.05 08:17:58 INFO - PID 1655 | Values: 67.0 67.0 66.0 67.0 68.0 69.0 66.0 67.0 68.0 66.0 08:17:58 INFO - PID 1655 | -------- Summary: end -------- 08:17:58 INFO - PID 1655 | 08:17:59 INFO - TEST-INFO | 1655: exit 0 08:18:00 INFO - TEST-OK | kraken | took 59643ms 08:18:00 INFO - SUITE-END | took 1179s 08:18:00 INFO - Completed test suite (00:19:39) 08:18:00 INFO - javascript benchmark 08:18:00 INFO - PERFHERDER_DATA: {"framework": {"name": "talos"}, "suites": [{"extraOptions": [], "name": "dromaeo_css", "lowerIsBetter": false, "alertThreshold": 5.0, "value": 7769.8881802776195, "subtests": [{"name": "dojo.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [2912.3447224374513, 3476.1657202271444, 3532.735044871635, 3545.734069944755, 3555.679988801008, 6131.774283661895, 6207.5033997280225, 6224.315325314217, 6265.404786545277, 6294.244690637119, 5222.164453687411, 6165.0, 6234.968825155868, 6248.406401391871, 6279.686015699208, 4341.696081274296, 5391.110466772978, 5429.56563474923, 5449.073657478239, 5494.313210848644, 5480.0, 5549.250851135105, 5552.11166213406, 5572.3870374258795, 5573.247611572447, 5361.571074314084, 5408.891822163574, 5418.997485465202, 5439.673619582798, 5489.972550137244, 5483.670979741189, 5486.231927530149, 5489.204065410493, 5490.3411590608985, 5503.587230957654, 5427.6472029317965, 5447.918281225785, 5455.0, 5465.6447330923365, 5466.890662186774, 6210.223722034746, 6229.2524897012645, 6229.6573688447115, 6230.314665386803, 6240.843978900519, 6440.0661904023655, 6589.538732288742, 6603.537752357337, 6645.036469711865, 6645.401913827779, 6635.004749287597, 6642.1033160523675, 6729.899051514182, 6774.898376524356, 6815.42068924142, 6276.96861515694, 6282.968585157045, 6292.087647291117, 6297.307296197415, 6299.0551417287315, 6901.930980690229, 6918.8962165567555, 6921.377076063078, 6928.861422771516, 6945.617991010442, 6373.107764912916, 6405.935940640627, 6417.839554011187, 6432.421082102634, 6524.869502609921, 6671.766488172891, 6680.031395447633, 6690.13028306317, 6710.798676039629, 6728.932710672831, 6545.869082618321, 6573.276939536647, 6585.670716464253, 6603.108580341593, 6616.4045235929, 6512.055751915946, 6630.502712296597, 6635.071090047397, 6640.435562977104, 6643.236027856762, 4291.399204111427, 5207.244949482304, 5212.869678258074, 5213.426523082458, 5226.372835259793, 4656.837010704609, 4661.696989695659, 4696.553827386393, 4749.976250118727, 4791.760411979457, 5113.360829896263, 6203.31763506014, 6234.906476402857, 6328.6202827830475, 6339.524535659844, 6742.460603151736, 6755.121834161528, 6759.053732477457, 6763.5265531413315, 6773.085633439521, 6323.241211054703, 6340.556161068681, 6348.428641422294, 6352.936470635327, 6354.205724284465, 5738.5982981191755, 5822.155787410802, 5829.183914252008, 5879.559033072536, 5888.087346461305, 5082.466341034138, 6917.7232910684015, 6986.16166060076, 6996.475264355296, 7001.719931202695, 6737.831554210988, 6772.627505487246, 6781.254062053269, 6786.117804685359, 6791.796246112624, 6948.930510694829, 6979.092717946837, 6980.755673551402, 6994.300569942965, 6998.335158159966, 6414.326495717883, 6450.161479007699, 6575.112359831362, 6645.1361323027695, 6736.663166841737, 5882.470577648032, 6088.946570633196, 6693.364130407798, 6716.932830671826, 6765.458763299022, 6480.611163330215, 6528.836779080561, 6531.020346947996, 6540.215174179129, 6562.5406221564035, 6265.185525881606, 6481.967590162019, 6494.6103233806125, 6502.154719886574, 6503.837404064936, 6340.207474065742, 6345.143405640364, 6347.143135676809, 6351.968240158954, 6352.174217351715, 6377.2984971654005, 6490.091387205889, 6537.05212744159, 6557.278699343164, 6575.309592492719, 6310.6844657766005, 6331.366863313632, 6360.427561519486, 6367.681615919279, 6385.521085918482], "value": 6071.000521398892, "unit": "score"}, {"name": "ext.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [786.7836345005123, 798.9680412783487, 1097.917656175787, 1117.793208256472, 1117.8435019097328, 27418.725812741868, 36994.0, 37287.62712372879, 37431.0, 37446.812765936134, 39599.80200099003, 39948.0, 39991.200175996535, 40072.599274007254, 40094.39858402126, 5972.0, 8311.459755115913, 8476.321894248476, 8479.703210387637, 8480.236778689916, 5993.88012239755, 8280.130586288444, 8421.663133474654, 8448.366372522054, 8459.280961118313, 8500.872486912702, 8518.48889066658, 8556.87164692527, 8560.78598035051, 8562.186592273723, 5902.704864756745, 8434.662613495484, 8472.74581762548, 8498.66286771143, 8499.0, 5950.9107363389585, 8118.903947967008, 8282.83434331316, 8288.129746376604, 8299.668013279523, 36645.900622981084, 36822.26355472903, 36974.0, 37022.0, 37125.628743712485, 3582.5521809773777, 3627.147620309225, 3628.1473853644375, 3631.963680363189, 3634.0, 30781.0, 30882.536761948588, 30920.381592368027, 30955.845220773976, 30969.845150774327, 3082.6300843898653, 3151.6060492438446, 3164.430402527544, 3172.1752344390625, 3172.809631422122, 271732.0, 276893.0, 276907.6154619214, 277199.6140019307, 277898.0, 39404.80297598494, 39565.604343956766, 49086.77283067952, 49274.0145197094, 49302.50697492979, 41078.973025674, 50598.24102638463, 50663.49336506661, 50717.0, 51128.21051263188, 13886.236257005961, 13985.930070349583, 14002.789958150635, 14004.43982240699, 14068.788968165485, 11347.262427942158, 11352.829707554394, 11357.091432685365, 11366.431678416046, 11367.20429569922, 12827.807582886264, 12828.29444380568, 12834.614961551168, 12857.485700571873, 12951.935240323737, 5364.892702145935, 5368.248445217672, 5377.596680248997, 5382.977234325465, 5389.8113566025, 932.0260327957301, 932.7248461703814, 1024.7386916336286, 1066.8773091094467, 1085.9402732849612, 23786.88106559456, 24827.5034499309, 24843.751562484504, 24884.0, 24912.37719057038, 1130.1636788776245, 1132.8017596920506, 1164.7495788405533, 1166.7958107331353, 1193.6061099837034, 10167.305663999046, 11309.264897781617, 12553.087308011232, 12603.495860165674, 12725.109242352946, 304873.0, 305752.0, 306314.0, 306933.0, 307303.0, 53361.0, 53435.0, 53499.73250133725, 53533.0, 53555.73222133942, 1523.2155439948435, 1564.8748100151734, 1581.4464937271862, 1582.2958783341533, 1582.374961890047, 17689.46931592054, 24183.879080605187, 24288.906999185434, 24338.391540211636, 24360.63459048151, 38798.80600596979, 38847.0, 38974.80512597419, 38977.6102238974, 38983.415248770725, 266746.0, 267313.0, 267354.0, 267430.0, 267538.64922701824, 29993.400131997674, 30124.84937575298, 34761.78333758306, 34839.65160348364, 35255.59305086864, 42364.94087647834, 42486.0, 43788.124237514436, 43907.560924390345, 43964.78017609892, 29375.559366609945, 29465.85267073651, 30275.697243028168, 30290.394192116473, 30624.92812751543, 29300.706992929798, 29649.555256670737, 30079.0, 30432.934847280238, 30484.237894051937, 30060.549091763205, 34813.43339549676, 36460.27079458449, 36570.81714591516, 36636.633633663325, 29609.703902961555, 29995.850020749756, 30333.69666303397, 30388.39223215479, 30628.0, 22286.554268914857, 23665.881670591538, 23770.76032680414, 24000.0, 24018.63972040386], "value": 17149.279201813024, "unit": "score"}, {"name": "jquery.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [390.46896221139247, 411.5801882080276, 416.768693375177, 418.78432607207276, 429.52108399134966, 19871.13568508225, 21046.0, 21818.0, 21982.34052978413, 22027.66958495622, 21564.245251416203, 21812.345629631098, 22100.557988840214, 22174.0, 22349.32952011438, 5715.828525144252, 6008.068749343859, 6008.218931538894, 6012.488938440238, 6024.0662697282, 5721.456461636138, 5780.277465316835, 5821.534277257831, 5900.940990590082, 5926.674032928187, 5881.323647780518, 5892.911606325909, 5895.528357731371, 5901.704914754267, 5909.940900591004, 5701.34434540027, 5870.207521984542, 5937.792177273818, 5986.790462333841, 6000.519958403317, 5179.870503237449, 5301.204819277101, 5325.813596524142, 5333.679979201261, 5351.983123206578, 27289.45421091587, 27759.028434004715, 27843.0, 28158.859205704044, 28233.294167645974, 2183.5087105401317, 2231.129859354853, 2260.152442833937, 2260.6722025306403, 2262.468319944812, 17579.912100439415, 17690.646187076185, 18116.728249076274, 18351.54121146969, 18389.448316550526, 2053.876767393961, 2140.3578926322043, 2149.022194901316, 2156.6225910465605, 2162.416147640144, 152830.47169528273, 160073.0, 160297.0, 162007.0, 170802.1459892705, 11572.0, 11695.532178712756, 11951.521939122338, 12068.396580171131, 12242.510299587917, 15943.24624291327, 15950.361985520682, 15983.440579579892, 15992.840071599136, 16009.0, 8573.156771294078, 8948.328875334377, 8948.463092214488, 9088.454692718326, 9126.17864392208, 8525.914740852511, 8570.357223208284, 8572.828543429096, 8731.345149113842, 8767.693130740394, 7507.8498430031095, 7627.733029343946, 7677.0, 7677.616119194018, 7700.306972372513, 1781.750554922312, 2035.328341647253, 2035.6793255688526, 2057.249104077001, 2219.178903805602, 925.1396201532639, 934.1125930366179, 946.31392240625, 947.4599478297305, 954.2604481526733, 20990.685139722915, 21591.460213494473, 21609.919504024736, 21640.783592164193, 21737.67393489099, 869.4305230074311, 974.7952929884661, 990.2127808392202, 994.8956658109493, 1005.4118340770731, 9141.588628511732, 10455.059044686015, 10493.632722854816, 10986.340819550853, 11034.834477482844, 434827.0, 478624.0, 537236.3138184284, 543102.0, 545528.0, 127456.36271818582, 132363.80724795043, 133253.0, 133526.33236833755, 135761.0, 1128.6783266768932, 1146.4611632532863, 1165.9125565582615, 1177.2289150606366, 1177.5113327968968, 17960.550986225448, 18450.723239151153, 18457.81542184561, 18506.44480665582, 18792.436226913214, 56263.0, 56295.0, 57154.28537143892, 57690.0, 57809.13286300793, 76451.61774191093, 77604.61197693975, 78705.0, 79895.2010479911, 81244.59377703074, 8540.829183416421, 8588.098249683693, 8629.050804411385, 8987.775305617412, 9041.864372034557, 13661.521846735317, 13969.952253581225, 14141.0, 14298.642533936734, 14379.856201437851, 11751.059915206934, 11824.0, 12059.51761929513, 12061.758764824479, 12140.878591213976, 9629.56666950003, 10350.706161729784, 10846.132309415385, 11090.611828585961, 11373.260738052, 9910.603575857174, 11848.58529951482, 12164.817527736914, 12234.327112008925, 12251.448684809384, 8560.828783424422, 8600.526971016403, 8757.562121894007, 8804.119588041145, 8818.955905220433, 9532.475713835805, 11640.359780211831, 11960.58137965167, 11963.0, 12046.939765301116], "value": 10274.04141615439, "unit": "score"}, {"name": "mootools.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [1194.4684615346175, 1394.9790753138702, 1412.2162199979007, 1430.6566424058228, 1443.0836418874014, 8455.450395724274, 9601.567929443174, 10018.24863135264, 10032.347897386664, 10037.247206459517, 10676.35941843488, 11314.660560183187, 11315.717107072327, 11319.886801131986, 11357.0, 2436.8537887726793, 2450.7426720194344, 2481.5781317176034, 2490.1533478617357, 2493.364192131004, 2071.7099606055162, 2314.241333883874, 2478.1945867593013, 2481.8759062046915, 2482.7641374069435, 2116.375669177596, 2150.118451434912, 2414.14297924237, 2488.1664642344836, 2499.4751102268547, 2442.804575633945, 2465.642481840132, 2468.2348471973655, 2471.530409222242, 2475.7771800537857, 2432.659427680126, 2432.902683892642, 2433.270018994295, 2437.878106094688, 2438.829281950264, 11335.659930202024, 11576.47905844239, 11585.957263846294, 11603.303801771921, 11631.883681163165, 6385.393387628168, 6638.0, 6644.734210631569, 6651.301613330579, 6682.632455214961, 3943.507061617298, 4152.211079894811, 4229.767362795045, 4314.331278651814, 4326.697131200817, 1233.876612338768, 1239.535174309634, 1281.724429247707, 1288.4330894406526, 1288.4395288049634, 16663.33346666144, 16691.582710432336, 16692.916535417367, 16705.415310464075, 16709.415170468976, 5055.938252966845, 5708.457696518824, 5876.236089308448, 5921.3190483094995, 6035.547333949883, 13623.978201634916, 13631.727365452834, 13638.454461821417, 13654.658633534242, 13656.863431365558, 6716.1604799400075, 6716.630585317855, 6721.361470660279, 6726.091977583062, 6756.797296081126, 4791.784369703302, 6015.947209238453, 6190.164327815687, 6227.0, 6227.408396202353, 4400.75795831226, 4484.439445069366, 4514.548545145459, 4573.702709323883, 4677.929831052537, 1398.4685819388772, 1423.3737155651481, 1426.7289215049107, 1446.197360464952, 1449.355037008521, 668.9063232083547, 719.9136103667594, 787.9015123109612, 805.9194080591894, 809.805646644801, 6412.61524308543, 6439.7424103035355, 6580.5722628029025, 6796.626185559743, 6885.345892140239, 910.8906931168302, 914.6570036236411, 922.0272612393854, 923.9122283383068, 954.236610711428, 3474.5483087198504, 4202.873913782591, 4261.552536983572, 4262.680298977589, 4401.559844015573, 14240.786388204186, 14943.77584336214, 14970.625734356729, 14975.550733478012, 15167.317470713844, 14405.92797036008, 14863.851361486462, 14939.02896311758, 14951.775723364159, 14968.775468367983, 8410.957945210235, 8653.437526560754, 8658.740237792876, 8667.479951203075, 8673.956630216808, 6556.18047744032, 6864.622445765531, 7036.648167591702, 7056.470764692771, 7088.964555177397, 11003.284786488852, 12937.611871643865, 13700.246486442942, 13700.65748356299, 13714.971377146954, 13433.596992090253, 13937.58187254384, 13944.58166255014, 14086.084404513675, 14292.571222863331, 9172.678956236767, 9457.716268511957, 9463.337566370563, 9472.100150485692, 9473.242140628596, 10492.317999330018, 10497.47512624381, 10526.368417894952, 10614.681559553226, 10637.680869573926, 8907.465552066897, 8954.507502087448, 9029.142231487998, 9053.864192037256, 9112.681056163003, 8712.39013269065, 8838.469691818511, 8845.0, 8871.64513419456, 8927.821443571222, 7984.20157984197, 8102.83794324122, 8107.675692972215, 8117.431779775359, 8122.390820688353, 5819.388964158702, 5848.53211743051, 5984.850378740566, 6067.12026756109, 6091.208142941389, 5465.344158700981, 5678.659280443187, 6056.57603967718, 6100.206973093647, 6267.655278959701], "value": 5352.730336971544, "unit": "score"}, {"name": "prototype.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [391.1453474158963, 395.8772780438066, 398.1221406798009, 401.927653022456, 405.6511400195829, 4280.700350975433, 5145.511176438237, 5663.235463212465, 5868.00243958527, 5878.650428110415, 5306.3632364116265, 5791.913121303184, 5814.680192589406, 5847.736851841667, 5855.47300742933, 4552.4764652065105, 4570.771461426932, 4586.894729217349, 4588.701734387271, 4622.768861556917, 3966.4050392441222, 4591.334256532801, 4595.8969847236585, 4600.056988317387, 4617.2381557043045, 4114.259433302004, 4393.912121757563, 4545.159145558082, 4579.084183163381, 4597.4483062032605, 3449.8792542261153, 4010.5588385277597, 4241.300185469394, 4469.843555475575, 4556.658250631182, 3526.0, 3552.378333791576, 3951.46655201547, 4070.267351876661, 4112.691548133872, 5187.844364669066, 5581.6930068846195, 5588.608797384185, 5679.375268720438, 5913.142594323799, 5378.327709036371, 5423.376311724162, 5431.83704488866, 5443.727813609304, 5494.450554944514, 5311.0, 5459.69971651559, 6180.536459765491, 6335.746570137189, 6342.968285158591, 4250.298700714378, 4270.658347332206, 4436.245838207513, 4601.884952876171, 4667.789949452249, 4932.558383600069, 5140.663427508837, 5829.387914269026, 6548.579708696659, 6612.239592446882, 4151.730137541111, 4385.495667998221, 4475.216837053503, 4563.133004729091, 4568.543145685405, 4278.465191851019, 4704.7412392318065, 4724.2205036169335, 4857.441394239637, 4866.78099485524, 4227.309076369415, 4437.911241775147, 4929.827456039022, 5208.947910520922, 5351.652142610717, 6195.783147589813, 6292.46514046302, 6314.179156709598, 6331.778387756406, 6368.936310636927, 1546.9767953480707, 1623.3993422433539, 1624.1554391716477, 1644.9506514804575, 1651.4385109062737, 1108.5842808946645, 1152.6023521884936, 1154.4862536171322, 1168.7968179980796, 1169.9590514332128, 5908.881822363614, 5915.556333274935, 5929.110633405024, 5940.70296485174, 5952.880942381128, 5183.455737147545, 6501.577397469149, 6505.4795616350575, 6515.609063456208, 6607.339266073354, 5649.435056494318, 5826.621269617462, 5859.677717725481, 5891.499222566044, 5906.2912450505355, 3248.1067706380463, 3352.6814952579953, 3411.0, 3413.6245013048547, 3416.777909435879, 5614.29821272341, 6452.709628066748, 6698.961660942562, 6717.56335838169, 6724.966375168093, 6525.575837570543, 6633.303503132198, 6637.435817955431, 6639.4024537790865, 6677.899831502531, 5414.269073675082, 6415.518836087312, 6668.166479190101, 6736.427403670743, 6743.0, 4852.417709874838, 5809.767609295581, 6153.446189842935, 6220.906686399798, 6464.254651244231, 5597.720113994365, 5675.432456754292, 6096.725647345791, 6173.259208894961, 6340.365963403623, 5571.08077167279, 6636.71033493444, 6668.6665666717445, 6706.66466676674, 6720.32796720324, 4544.091181763594, 4582.358469814162, 4731.526847315241, 4733.83431579893, 4790.329353890528, 6353.426862120848, 6399.584027038228, 6445.12990746262, 6488.837779055561, 6495.577787443801, 5301.4168441472175, 6191.380861913773, 6224.221972253468, 6235.563510554399, 6249.9062514063235, 5083.38999320084, 5354.651947623392, 5993.340732519507, 6019.0, 6299.748010079546, 5415.48552887475, 5755.61865152352, 6096.591846220629, 6109.877802443837, 6165.321814600301, 4772.7136371817805, 6242.692542145905, 6261.342559031236, 6283.874322513616, 6310.211223597051, 5292.3649162099255, 5304.708241046779, 5671.376148623565, 6073.817785466443, 6106.267247930099], "value": 4631.988757680389, "unit": "score"}, {"name": "yui.html", "lowerIsBetter": false, "alertThreshold": 5.0, "replicates": [830.0744669693294, 853.4154104438456, 854.679495189304, 855.4653341661461, 872.0668884293808, 14192.716145677094, 15668.686626267468, 16262.75605865913, 16567.100757367472, 16597.41909033184, 17740.556486087822, 17756.289748410047, 18138.3651572195, 18217.0, 18298.817011829877, 805.629410471184, 923.5751554285036, 956.6699488676395, 959.4147569982305, 959.6737109382808, 997.8104160209573, 997.9351342162772, 998.2014388489216, 1000.304788172217, 1005.5977608956439, 1002.0680766886792, 1002.8395456726888, 1003.9548220330103, 1004.1464754958264, 1041.666666666667, 1001.9549120289604, 1002.0680766886792, 1003.4631472162395, 1003.5534187286661, 1042.5412818359935, 731.5756861020595, 733.2484203691206, 733.2667332667332, 743.8400743840047, 769.1769806307253, 13071.0, 13497.190168589916, 16989.660206795794, 17145.914270428693, 17185.96884186953, 14622.926885365612, 17014.78807754996, 17207.88148770326, 17439.564010899703, 17642.735358969625, 14010.439582416691, 14081.08472949255, 14093.224872632001, 14162.575122746232, 14331.355089021019, 3483.9825800871085, 3507.421275489541, 3507.719382449398, 3514.578250609943, 3516.613172551017, 92408.53795731046, 135625.0, 136269.0, 138636.30681846628, 138858.0, 10377.584896604052, 10787.78424431507, 11139.665810025712, 11537.307761534335, 13943.0, 25285.0, 25600.871995639904, 25818.0, 26164.476710466064, 26358.604620930702, 7814.765557033298, 7980.840383192303, 8063.798405039921, 8090.959545202354, 8119.188081191834, 3940.389239667856, 3998.460207871958, 4001.6198461146146, 4001.799910004488, 4003.159336539359, 4331.328644060176, 4377.4965878923695, 4380.342948557678, 4401.801918913657, 4443.422355093817, 925.7546750111226, 946.0161432110528, 947.9810403791886, 951.9381240219363, 953.537534295866, 649.7855707616475, 650.1483057195089, 650.9967450162814, 660.7257987934953, 685.5475386245055, 10370.585176593002, 11243.212975091828, 11323.094152467782, 11913.285202887855, 11952.04383649306, 640.2029473305764, 656.6486929492698, 663.5852592129919, 671.7145213284334, 689.762032098925, 4839.854804355875, 5449.6730196188355, 5487.451254874561, 5526.972365138148, 5616.943830561642, 86394.0, 103656.96343036473, 105048.0, 107119.0, 107270.92729072766, 93621.5318923401, 95358.52320738352, 96434.0, 96671.0, 97619.0, 81355.0, 81997.0, 82852.0, 83118.58440707879, 84141.15858841334, 9531.809363812547, 11246.831297530707, 11804.409779511161, 11932.105092117952, 12284.01727861751, 39387.42450301956, 39397.0, 39813.60186398215, 39994.800025999684, 40090.39864402095, 43310.83445827759, 47576.762116189195, 50756.23865642092, 51035.48964510307, 51920.0, 16107.516774496784, 16465.600423964097, 16738.163091845116, 16787.0, 16793.32826686919, 18047.318092710382, 18191.636167276316, 18357.3574924877, 18490.075496225403, 18697.0, 16540.66918661644, 17001.829981700026, 17131.571710707332, 17169.055701936515, 17356.47930562085, 16608.58478537998, 16708.248128833988, 16728.498145055666, 17038.659226815642, 17061.0, 16203.918980405022, 16564.585885352964, 16619.91690041542, 16638.833611664213, 16765.66468670644, 11575.247608905394, 11625.418729063682, 12017.278963262232, 12131.939340303243, 12455.439505222106, 12546.0, 12770.744585108432, 12867.742645146858, 12961.416736246703, 12985.930585597385], "value": 8295.972365065558, "unit": "score"}]}, {"extraOptions": [], "name": "kraken", "lowerIsBetter": true, "alertThreshold": 2.0, "value": 1412.8999999999999, "subtests": [{"name": "ai-astar", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [111.0, 111.0, 111.0, 111.0, 111.0, 112.0, 111.0, 111.0, 111.0, 111.0], "value": 111.1, "unit": "score"}, {"name": "audio-beat-detection", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 109.0, 109.0, 150.0, 110.0, 109.0, 106.0, 108.0, 137.0, 107.0], "value": 118.3, "unit": "score"}, {"name": "audio-dft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [186.0, 186.0, 184.0, 186.0, 187.0, 184.0, 183.0, 188.0, 185.0, 181.0], "value": 185.0, "unit": "score"}, {"name": "audio-fft", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [81.0, 61.0, 61.0, 89.0, 61.0, 60.0, 59.0, 62.0, 81.0, 57.0], "value": 67.2, "unit": "score"}, {"name": "audio-oscillator", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 70.0, 85.0, 68.0, 69.0, 67.0, 88.0, 68.0, 67.0, 90.0], "value": 76.2, "unit": "score"}, {"name": "imaging-gaussian-blur", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [90.0, 90.0, 90.0, 90.0, 90.0, 89.0, 90.0, 90.0, 90.0, 91.0], "value": 90.0, "unit": "score"}, {"name": "imaging-darkroom", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [97.0, 95.0, 96.0, 98.0, 96.0, 96.0, 97.0, 97.0, 97.0, 95.0], "value": 96.4, "unit": "score"}, {"name": "imaging-desaturate", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [85.0, 84.0, 87.0, 87.0, 86.0, 85.0, 85.0, 83.0, 86.0, 86.0], "value": 85.4, "unit": "score"}, {"name": "json-parse-financial", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [50.0, 48.0, 47.0, 47.0, 49.0, 50.0, 48.0, 48.0, 49.0, 48.0], "value": 48.4, "unit": "score"}, {"name": "json-stringify-tinderbox", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [54.0, 52.0, 60.0, 68.0, 62.0, 60.0, 57.0, 57.0, 57.0, 55.0], "value": 58.2, "unit": "score"}, {"name": "stanford-crypto-aes", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [83.0, 78.0, 82.0, 75.0, 81.0, 83.0, 80.0, 83.0, 81.0, 81.0], "value": 80.7, "unit": "score"}, {"name": "stanford-crypto-ccm", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [138.0, 133.0, 137.0, 135.0, 135.0, 142.0, 119.0, 136.0, 195.0, 168.0], "value": 143.8, "unit": "score"}, {"name": "stanford-crypto-pbkdf2", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [168.0, 229.0, 187.0, 183.0, 182.0, 182.0, 184.0, 174.0, 179.0, 183.0], "value": 185.1, "unit": "score"}, {"name": "stanford-crypto-sha256-iterative", "lowerIsBetter": true, "alertThreshold": 2.0, "replicates": [67.0, 67.0, 66.0, 67.0, 68.0, 69.0, 66.0, 67.0, 68.0, 66.0], "value": 67.1, "unit": "score"}]}]} 08:18:00 INFO - Return code: 0 08:18:00 INFO - Validating PERFHERDER_DATA against /builds/slave/test/scripts/external_tools/performance-artifact-schema.json 08:18:00 INFO - # TBPL SUCCESS # 08:18:00 INFO - Running pre test command check_screen_resolution with 'bash -c screenresolution get && screenresolution list && system_profiler SPDisplaysDataType' 08:18:00 INFO - Running command: ['bash', '-c', 'screenresolution get && screenresolution list && system_profiler SPDisplaysDataType'] in /builds/slave/test/build 08:18:00 INFO - Copy/paste: bash -c "screenresolution get && screenresolution list && system_profiler SPDisplaysDataType" 08:18:00 INFO - 2017-05-05 08:18:00.249 screenresolution[1660:9892] starting screenresolution argv=screenresolution get 08:18:00 INFO - 2017-05-05 08:18:00.252 screenresolution[1660:9892] Display 0: 1600x1200x32@60 08:18:00 INFO - 2017-05-05 08:18:00.258 screenresolution[1661:9895] starting screenresolution argv=screenresolution list 08:18:00 INFO - Available Modes on Display 0 08:18:00 INFO - 1600x1200x32@60 1152x870x32@75 1280x1024x32@75 08:18:00 INFO - 1024x768x32@75 1024x768x32@70 1024x768x32@60 08:18:00 INFO - 800x600x32@75 800x600x32@60 640x480x32@75 08:18:00 INFO - 640x480x32@60 1280x1024x32@60 1280x960x32@60 08:18:00 INFO - 1280x960x32@75 1344x1008x32@60 Graphics/Displays: 08:18:00 INFO - Intel Iris: 08:18:00 INFO - Chipset Model: Intel Iris 08:18:00 INFO - Type: GPU 08:18:00 INFO - Bus: Built-In 08:18:00 INFO - VRAM (Dynamic, Max): 1536 MB 08:18:00 INFO - Vendor: Intel (0x8086) 08:18:00 INFO - Device ID: 0x0a2e 08:18:00 INFO - Revision ID: 0x0009 08:18:00 INFO - Displays: 08:18:00 INFO - Display: 08:18:00 INFO - Resolution: 1600 x 1200 @ 60 Hz 08:18:00 INFO - Pixel Depth: 32-Bit Color (ARGB8888) 08:18:00 INFO - Display Serial Number: 1600x1200 60 08:18:00 INFO - Main Display: Yes 08:18:00 INFO - Mirror: Off 08:18:00 INFO - Online: Yes 08:18:00 INFO - Rotation: Supported 08:18:00 INFO - Return code: 0 08:18:00 INFO - Running post-action listener: _resource_record_post_action 08:18:00 INFO - [mozharness: 2017-05-05 15:18:00.503158Z] Finished run-tests step (success) 08:18:00 INFO - Running post-run listener: _resource_record_post_run 08:18:00 INFO - Total resource usage - Wall time: 1200s; CPU: 53.0%; Read bytes: 39544320; Write bytes: 506661888; Read time: 387; Write time: 1680 08:18:00 INFO - TinderboxPrint: CPU usage
53.3% 08:18:00 INFO - TinderboxPrint: I/O read bytes / time
39,544,320 / 387 08:18:00 INFO - TinderboxPrint: I/O write bytes / time
506,661,888 / 1,680 08:18:00 INFO - TinderboxPrint: CPU idle
2,242.8 (46.7%) 08:18:00 INFO - TinderboxPrint: CPU system
956.3 (19.9%) 08:18:00 INFO - TinderboxPrint: CPU user
1,602.6 (33.4%) 08:18:00 INFO - TinderboxPrint: Swap in / out
247,345,152 / 0 08:18:00 INFO - install - Wall time: 20s; CPU: 54.0%; Read bytes: 205779456; Write bytes: 204720128; Read time: 15976; Write time: 382 08:18:00 INFO - run-tests - Wall time: 1181s; CPU: 53.0%; Read bytes: 35112448; Write bytes: 294740992; Read time: 354; Write time: 1269 08:18:01 INFO - Running post-run listener: _upload_blobber_files 08:18:01 INFO - Blob upload gear active. 08:18:01 INFO - Preparing to upload files from /builds/slave/test/build/blobber_upload_dir. 08:18:01 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 08:18:01 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'] 08:18:01 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 08:18:01 INFO - (blobuploader) - INFO - Open directory for files ... 08:18:01 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_errorsummary.log ... 08:18:01 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:01 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:02 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_errorsummary.log: uploaded 08:18:02 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:02 INFO - (blobuploader) - INFO - Done attempting. 08:18:02 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/dromaeojs_raw.log ... 08:18:02 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:02 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:03 INFO - (blobuploader) - INFO - TinderboxPrint: dromaeojs_raw.log: uploaded 08:18:03 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:03 INFO - (blobuploader) - INFO - Done attempting. 08:18:03 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/perfherder-data.json ... 08:18:03 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:03 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:04 INFO - (blobuploader) - INFO - TinderboxPrint: perfherder-data.json: uploaded 08:18:04 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:04 INFO - (blobuploader) - INFO - Done attempting. 08:18:04 INFO - (blobuploader) - INFO - Uploading /builds/slave/test/build/blobber_upload_dir/resource-usage.json ... 08:18:04 INFO - (blobuploader) - INFO - Using https://blobupload.elasticbeanstalk.com 08:18:04 INFO - (blobuploader) - INFO - Uploading, attempt #1. 08:18:06 INFO - (blobuploader) - INFO - TinderboxPrint: resource-usage.json: uploaded 08:18:06 INFO - (blobuploader) - INFO - Blobserver returned 202. File uploaded! 08:18:06 INFO - (blobuploader) - INFO - Done attempting. 08:18:06 INFO - (blobuploader) - INFO - Iteration through files over. 08:18:06 INFO - Return code: 0 08:18:06 INFO - rmtree: /builds/slave/test/build/uploaded_files.json 08:18:06 INFO - retry: Calling remove with args: ('/builds/slave/test/build/uploaded_files.json',), kwargs: {}, attempt #1 08:18:06 INFO - Setting buildbot property blobber_files to {"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43b7b113c5b1bb5b21c7e0951b4baffc9a5facf7510889b54007e3171d367f513f0fe97074ee5d58cf830e92276f0d5f91b8c2f3fab84380fc08ebe6c8eee3dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e189e56a52228ab0abcc1e57cca4ba5ba22869052162f509b1f3426cd71e589a8380c8b0d939deadb4a7f0751510f0245403d03f23d2120ceaf2e37a73b52d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf9ef0e4dc3e3a85043bec92a877ba29aa3c8cb75103e72fbdb8b5f5c6c41da0a01e99c0abde4110f6dd946eb988abc7cc65e6e2347b5693eb611b603c46723f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/145f686cbc5eba8119569191b8a55e15419da5c19352468d80555df0fb4aeedf65fcc370e9cafa928233ac098d2931c5670f751aa27f37709ad2f0c85275699f"} 08:18:06 INFO - Writing buildbot properties ['blobber_files'] to /builds/slave/test/properties/blobber_files 08:18:06 INFO - Writing to file /builds/slave/test/properties/blobber_files 08:18:06 INFO - Contents: 08:18:06 INFO - blobber_files:{"dromaeojs_raw.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/43b7b113c5b1bb5b21c7e0951b4baffc9a5facf7510889b54007e3171d367f513f0fe97074ee5d58cf830e92276f0d5f91b8c2f3fab84380fc08ebe6c8eee3dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e189e56a52228ab0abcc1e57cca4ba5ba22869052162f509b1f3426cd71e589a8380c8b0d939deadb4a7f0751510f0245403d03f23d2120ceaf2e37a73b52d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf9ef0e4dc3e3a85043bec92a877ba29aa3c8cb75103e72fbdb8b5f5c6c41da0a01e99c0abde4110f6dd946eb988abc7cc65e6e2347b5693eb611b603c46723f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/145f686cbc5eba8119569191b8a55e15419da5c19352468d80555df0fb4aeedf65fcc370e9cafa928233ac098d2931c5670f751aa27f37709ad2f0c85275699f"} 08:18:06 INFO - Running post-run listener: copy_logs_to_upload_dir 08:18:06 INFO - Copying logs to upload dir... 08:18:06 INFO - mkdir: /builds/slave/test/build/upload/logs 08:18:06 INFO - Copying logs to upload dir... program finished with exit code 0 elapsedTime=1277.417926 ========= master_lag: 0.53 ========= ========= Finished '/tools/buildbot/bin/python -u ...' (results: 0, elapsed: 21 mins, 17 secs) (at 2017-05-05 08:18:06.359553) ========= ========= Started set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 08:18:06.363565) ========= 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.N9XodRpkAm/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.oIhna2G1pN/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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/43b7b113c5b1bb5b21c7e0951b4baffc9a5facf7510889b54007e3171d367f513f0fe97074ee5d58cf830e92276f0d5f91b8c2f3fab84380fc08ebe6c8eee3dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e189e56a52228ab0abcc1e57cca4ba5ba22869052162f509b1f3426cd71e589a8380c8b0d939deadb4a7f0751510f0245403d03f23d2120ceaf2e37a73b52d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf9ef0e4dc3e3a85043bec92a877ba29aa3c8cb75103e72fbdb8b5f5c6c41da0a01e99c0abde4110f6dd946eb988abc7cc65e6e2347b5693eb611b603c46723f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/145f686cbc5eba8119569191b8a55e15419da5c19352468d80555df0fb4aeedf65fcc370e9cafa928233ac098d2931c5670f751aa27f37709ad2f0c85275699f"} build_url:https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/artifacts/public/build/firefox-55.0a1.en-US.mac.dmg program finished with exit code 0 elapsedTime=0.010888 build_url: 'https://queue.taskcluster.net/v1/task/DaOGcOkeTCubwTFryE3Bdw/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/43b7b113c5b1bb5b21c7e0951b4baffc9a5facf7510889b54007e3171d367f513f0fe97074ee5d58cf830e92276f0d5f91b8c2f3fab84380fc08ebe6c8eee3dc", "dromaeojs_errorsummary.log": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/3e189e56a52228ab0abcc1e57cca4ba5ba22869052162f509b1f3426cd71e589a8380c8b0d939deadb4a7f0751510f0245403d03f23d2120ceaf2e37a73b52d4", "resource-usage.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/bf9ef0e4dc3e3a85043bec92a877ba29aa3c8cb75103e72fbdb8b5f5c6c41da0a01e99c0abde4110f6dd946eb988abc7cc65e6e2347b5693eb611b603c46723f", "perfherder-data.json": "http://mozilla-releng-blobs.s3.amazonaws.com/blobs/Firefox/sha512/145f686cbc5eba8119569191b8a55e15419da5c19352468d80555df0fb4aeedf65fcc370e9cafa928233ac098d2931c5670f751aa27f37709ad2f0c85275699f"}' ========= master_lag: 0.03 ========= ========= Finished set props: build_url blobber_files (results: 0, elapsed: 0 secs) (at 2017-05-05 08:18:06.401676) ========= ========= Started 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 08:18:06.402004) ========= 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.N9XodRpkAm/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.oIhna2G1pN/Listeners TMPDIR=/var/folders/6k/fq_g2pq17rxc93pg__4q5kx800000w/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.004632 ========= master_lag: 0.04 ========= ========= Finished 'rm -f ...' (results: 0, elapsed: 0 secs) (at 2017-05-05 08:18:06.450230) ========= ========= Started reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 08:18:06.450582) ========= ========= Finished reboot skipped (results: 3, elapsed: 0 secs) (at 2017-05-05 08:18:06.450967) ========= ========= Total master_lag: 0.68 =========